{"level":"warn","ts":"2026-07-17T11:01:21.695011Z","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-17T11:01:21.69509Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.57: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.57:2380","--initial-cluster=instance=https://199.204.45.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.57: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-17T11:01:21.69515Z","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-17T11:01:21.695158Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-07-17T11:01:21.695173Z","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-17T11:01:21.695775Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"]} {"level":"info","ts":"2026-07-17T11:01:21.695846Z","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.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.57: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-17T11:01:21.698513Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.468952ms"} {"level":"info","ts":"2026-07-17T11:01:21.710309Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b6478f0ac5aeb8e1","cluster-id":"6c58cff80d4a5b62"} {"level":"info","ts":"2026-07-17T11:01:21.710407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=()"} {"level":"info","ts":"2026-07-17T11:01:21.710447Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 0"} {"level":"info","ts":"2026-07-17T11:01:21.710467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b6478f0ac5aeb8e1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-17T11:01:21.71049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 1"} {"level":"info","ts":"2026-07-17T11:01:21.710548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"warn","ts":"2026-07-17T11:01:21.716597Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-17T11:01:21.718014Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-17T11:01:21.718983Z","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-17T11:01:21.721014Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b6478f0ac5aeb8e1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-17T11:01:21.721211Z","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-17T11:01:21.721293Z","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-17T11:01:21.721304Z","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-17T11:01:21.723221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"info","ts":"2026-07-17T11:01:21.721252Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b6478f0ac5aeb8e1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-17T11:01:21.724097Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","added-peer-id":"b6478f0ac5aeb8e1","added-peer-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-07-17T11:01:21.725886Z","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-17T11:01:21.725976Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-07-17T11:01:21.726094Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-07-17T11:01:21.726366Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b6478f0ac5aeb8e1","initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-17T11:01:21.726466Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-17T11:01:22.416289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 is starting a new election at term 1"} {"level":"info","ts":"2026-07-17T11:01:22.416363Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-17T11:01:22.41641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgPreVoteResp from b6478f0ac5aeb8e1 at term 1"} {"level":"info","ts":"2026-07-17T11:01:22.416431Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became candidate at term 2"} {"level":"info","ts":"2026-07-17T11:01:22.416449Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgVoteResp from b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-07-17T11:01:22.416466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became leader at term 2"} {"level":"info","ts":"2026-07-17T11:01:22.416485Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b6478f0ac5aeb8e1 elected leader b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-07-17T11:01:22.417707Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b6478f0ac5aeb8e1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.57:2379]}","request-path":"/0/members/b6478f0ac5aeb8e1/attributes","cluster-id":"6c58cff80d4a5b62","publish-timeout":"7s"} {"level":"info","ts":"2026-07-17T11:01:22.417856Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-17T11:01:22.41796Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-17T11:01:22.418111Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T11:01:22.41921Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T11:01:22.419336Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T11:01:22.419368Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T11:01:22.419527Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.57:2379"} {"level":"info","ts":"2026-07-17T11:01:22.419618Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-17T11:01:22.419661Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-17T11:01:22.421321Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-07-17T11:01:25.527869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.080133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T11:01:25.527996Z","caller":"traceutil/trace.go:171","msg":"trace[607982058] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:0; response_revision:195; }","duration":"172.262478ms","start":"2026-07-17T11:01:25.355702Z","end":"2026-07-17T11:01:25.527965Z","steps":["trace[607982058] 'range keys from in-memory index tree' (duration: 171.97307ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:01:25.918192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.950562ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-07-17T11:01:25.918406Z","caller":"traceutil/trace.go:171","msg":"trace[227295322] transaction","detail":"{read_only:false; response_revision:197; number_of_response:1; }","duration":"320.066696ms","start":"2026-07-17T11:01:25.598319Z","end":"2026-07-17T11:01:25.918386Z","steps":["trace[227295322] 'process raft request' (duration: 319.975724ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:01:25.918404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:01:25.529087Z","time spent":"389.311694ms","remote":"127.0.0.1:51686","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-07-17T11:01:25.918942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:01:25.598295Z","time spent":"320.20942ms","remote":"127.0.0.1:51946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":342,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-17T11:01:26.165491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.96783ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-17T11:01:26.165679Z","caller":"traceutil/trace.go:171","msg":"trace[535794581] transaction","detail":"{read_only:false; response_revision:201; number_of_response:1; }","duration":"242.849397ms","start":"2026-07-17T11:01:25.922816Z","end":"2026-07-17T11:01:26.165665Z","steps":["trace[535794581] 'process raft request' (duration: 242.814326ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:01:26.165798Z","caller":"traceutil/trace.go:171","msg":"trace[742801388] transaction","detail":"{read_only:false; response_revision:200; number_of_response:1; }","duration":"245.862274ms","start":"2026-07-17T11:01:25.919896Z","end":"2026-07-17T11:01:26.165758Z","steps":["trace[742801388] 'process raft request' (duration: 245.705519ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:01:26.166115Z","caller":"traceutil/trace.go:171","msg":"trace[1289793883] transaction","detail":"{read_only:false; response_revision:199; number_of_response:1; }","duration":"259.56399ms","start":"2026-07-17T11:01:25.906133Z","end":"2026-07-17T11:01:26.165697Z","steps":["trace[1289793883] 'process raft request' (duration: 259.422566ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:01:26.166228Z","caller":"traceutil/trace.go:171","msg":"trace[912295682] transaction","detail":"{read_only:false; response_revision:198; number_of_response:1; }","duration":"409.364979ms","start":"2026-07-17T11:01:25.756843Z","end":"2026-07-17T11:01:26.166208Z","steps":["trace[912295682] 'process raft request' (duration: 301.63723ms)","trace[912295682] 'compare' (duration: 106.894008ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T11:01:26.166426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:01:25.756823Z","time spent":"409.558246ms","remote":"127.0.0.1:51826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5877,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T11:01:59.946791Z","caller":"traceutil/trace.go:171","msg":"trace[952988114] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:606; }","duration":"188.332836ms","start":"2026-07-17T11:01:59.758435Z","end":"2026-07-17T11:01:59.946768Z","steps":["trace[952988114] 'read index received' (duration: 149.920197ms)","trace[952988114] 'applied index is now lower than readState.Index' (duration: 38.411709ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T11:01:59.947136Z","caller":"traceutil/trace.go:171","msg":"trace[726293927] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"331.598917ms","start":"2026-07-17T11:01:59.615497Z","end":"2026-07-17T11:01:59.947096Z","steps":["trace[726293927] 'process raft request' (duration: 293.001774ms)","trace[726293927] 'compare' (duration: 38.169452ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T11:01:59.947295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:01:59.615455Z","time spent":"331.770482ms","remote":"127.0.0.1:51690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-17T11:01:59.947593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.419283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T11:01:59.947904Z","caller":"traceutil/trace.go:171","msg":"trace[676452868] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:580; }","duration":"135.762882ms","start":"2026-07-17T11:01:59.812122Z","end":"2026-07-17T11:01:59.947885Z","steps":["trace[676452868] 'agreement among raft nodes before linearized reading' (duration: 135.417233ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:01:59.947744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.198997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-17T11:01:59.948081Z","caller":"traceutil/trace.go:171","msg":"trace[1402015172] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:580; }","duration":"189.657449ms","start":"2026-07-17T11:01:59.758403Z","end":"2026-07-17T11:01:59.948061Z","steps":["trace[1402015172] 'agreement among raft nodes before linearized reading' (duration: 188.828389ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:01:59.947829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.590289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-fgfsr\" ","response":"range_response_count:1 size:4679"} {"level":"info","ts":"2026-07-17T11:01:59.94839Z","caller":"traceutil/trace.go:171","msg":"trace[787300892] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-fgfsr; range_end:; response_count:1; response_revision:580; }","duration":"123.200415ms","start":"2026-07-17T11:01:59.825173Z","end":"2026-07-17T11:01:59.948373Z","steps":["trace[787300892] 'agreement among raft nodes before linearized reading' (duration: 122.507616ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:02:00.184249Z","caller":"traceutil/trace.go:171","msg":"trace[1019987555] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"229.967115ms","start":"2026-07-17T11:01:59.954234Z","end":"2026-07-17T11:02:00.184201Z","steps":["trace[1019987555] 'process raft request' (duration: 229.834042ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:02:00.186878Z","caller":"traceutil/trace.go:171","msg":"trace[741731819] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"231.737649ms","start":"2026-07-17T11:01:59.955128Z","end":"2026-07-17T11:02:00.186865Z","steps":["trace[741731819] 'process raft request' (duration: 231.623346ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:02:00.187119Z","caller":"traceutil/trace.go:171","msg":"trace[2103855746] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"231.616228ms","start":"2026-07-17T11:01:59.955493Z","end":"2026-07-17T11:02:00.187109Z","steps":["trace[2103855746] 'process raft request' (duration: 231.33759ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:02:00.187159Z","caller":"traceutil/trace.go:171","msg":"trace[1591583878] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"229.296469ms","start":"2026-07-17T11:01:59.957844Z","end":"2026-07-17T11:02:00.187141Z","steps":["trace[1591583878] 'process raft request' (duration: 229.164646ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:02:00.187174Z","caller":"traceutil/trace.go:171","msg":"trace[1802049784] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"173.438251ms","start":"2026-07-17T11:02:00.013709Z","end":"2026-07-17T11:02:00.187147Z","steps":["trace[1802049784] 'process raft request' (duration: 173.39269ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:02:05.965692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.137573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-h4r4v\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-07-17T11:02:05.965787Z","caller":"traceutil/trace.go:171","msg":"trace[730904811] range","detail":"{range_begin:/registry/pods/kube-system/cilium-h4r4v; range_end:; response_count:1; response_revision:645; }","duration":"121.280135ms","start":"2026-07-17T11:02:05.844489Z","end":"2026-07-17T11:02:05.965769Z","steps":["trace[730904811] 'range keys from in-memory index tree' (duration: 120.962568ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:02:06.738301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.418632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T11:02:06.738901Z","caller":"traceutil/trace.go:171","msg":"trace[2010190946] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:648; }","duration":"280.064899ms","start":"2026-07-17T11:02:06.458815Z","end":"2026-07-17T11:02:06.73888Z","steps":["trace[2010190946] 'range keys from in-memory index tree' (duration: 279.329639ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:02:06.738337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.002648ms","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-17T11:02:06.739145Z","caller":"traceutil/trace.go:171","msg":"trace[756881956] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:648; }","duration":"111.851398ms","start":"2026-07-17T11:02:06.627263Z","end":"2026-07-17T11:02:06.739115Z","steps":["trace[756881956] 'range keys from in-memory index tree' (duration: 110.825083ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:02:06.895268Z","caller":"traceutil/trace.go:171","msg":"trace[1330406485] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"151.040506ms","start":"2026-07-17T11:02:06.744204Z","end":"2026-07-17T11:02:06.895244Z","steps":["trace[1330406485] 'process raft request' (duration: 150.913903ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:02:22.584474Z","caller":"traceutil/trace.go:171","msg":"trace[424453839] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"159.634994ms","start":"2026-07-17T11:02:22.424811Z","end":"2026-07-17T11:02:22.584446Z","steps":["trace[424453839] 'process raft request' (duration: 158.325881ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:02:55.769116Z","caller":"traceutil/trace.go:171","msg":"trace[789823033] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"150.705992ms","start":"2026-07-17T11:02:55.618366Z","end":"2026-07-17T11:02:55.769072Z","steps":["trace[789823033] 'process raft request' (duration: 150.529338ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:03:19.199882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.470302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-17T11:03:19.199973Z","caller":"traceutil/trace.go:171","msg":"trace[147459286] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1044; }","duration":"368.599937ms","start":"2026-07-17T11:03:18.831353Z","end":"2026-07-17T11:03:19.199953Z","steps":["trace[147459286] 'range keys from in-memory index tree' (duration: 368.313339ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:03:19.200014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:03:18.831333Z","time spent":"368.671879ms","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-17T11:03:19.200012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.109879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-17T11:03:19.20098Z","caller":"traceutil/trace.go:171","msg":"trace[472566404] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1044; }","duration":"542.01244ms","start":"2026-07-17T11:03:18.658839Z","end":"2026-07-17T11:03:19.200851Z","steps":["trace[472566404] 'range keys from in-memory index tree' (duration: 540.951805ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:03:19.201043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:03:18.658821Z","time spent":"542.206136ms","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-17T11:03:19.337218Z","caller":"traceutil/trace.go:171","msg":"trace[1220411709] linearizableReadLoop","detail":"{readStateIndex:1092; appliedIndex:1090; }","duration":"111.011234ms","start":"2026-07-17T11:03:19.22618Z","end":"2026-07-17T11:03:19.337191Z","steps":["trace[1220411709] 'read index received' (duration: 24.769953ms)","trace[1220411709] 'applied index is now lower than readState.Index' (duration: 86.240261ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T11:03:19.337246Z","caller":"traceutil/trace.go:171","msg":"trace[1859769049] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"132.898745ms","start":"2026-07-17T11:03:19.204324Z","end":"2026-07-17T11:03:19.337223Z","steps":["trace[1859769049] 'process raft request' (duration: 132.477174ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:03:19.337396Z","caller":"traceutil/trace.go:171","msg":"trace[2008998071] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"132.360361ms","start":"2026-07-17T11:03:19.204985Z","end":"2026-07-17T11:03:19.337345Z","steps":["trace[2008998071] 'process raft request' (duration: 132.152436ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:03:19.337555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.340083ms","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-17T11:03:19.337626Z","caller":"traceutil/trace.go:171","msg":"trace[36992349] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1047; }","duration":"111.458235ms","start":"2026-07-17T11:03:19.226151Z","end":"2026-07-17T11:03:19.337609Z","steps":["trace[36992349] 'agreement among raft nodes before linearized reading' (duration: 111.186148ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:03:19.567321Z","caller":"traceutil/trace.go:171","msg":"trace[2141639943] linearizableReadLoop","detail":"{readStateIndex:1095; appliedIndex:1094; }","duration":"108.149371ms","start":"2026-07-17T11:03:19.459151Z","end":"2026-07-17T11:03:19.5673Z","steps":["trace[2141639943] 'read index received' (duration: 49.033524ms)","trace[2141639943] 'applied index is now lower than readState.Index' (duration: 59.114747ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T11:03:19.567428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.274304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T11:03:19.567477Z","caller":"traceutil/trace.go:171","msg":"trace[1617068608] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1050; }","duration":"108.386428ms","start":"2026-07-17T11:03:19.459076Z","end":"2026-07-17T11:03:19.567462Z","steps":["trace[1617068608] 'agreement among raft nodes before linearized reading' (duration: 108.294546ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:03:19.567846Z","caller":"traceutil/trace.go:171","msg":"trace[2024446960] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"191.211142ms","start":"2026-07-17T11:03:19.376616Z","end":"2026-07-17T11:03:19.567827Z","steps":["trace[2024446960] 'process raft request' (duration: 131.633913ms)","trace[2024446960] 'compare' (duration: 58.941023ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T11:03:21.702994Z","caller":"traceutil/trace.go:171","msg":"trace[966700961] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"356.325888ms","start":"2026-07-17T11:03:21.346644Z","end":"2026-07-17T11:03:21.70297Z","steps":["trace[966700961] 'process raft request' (duration: 356.185595ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:03:21.703523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:03:21.346618Z","time spent":"356.44499ms","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T11:03:21.892336Z","caller":"traceutil/trace.go:171","msg":"trace[721675335] linearizableReadLoop","detail":"{readStateIndex:1099; appliedIndex:1097; }","duration":"544.830621ms","start":"2026-07-17T11:03:21.347484Z","end":"2026-07-17T11:03:21.892314Z","steps":["trace[721675335] 'read index received' (duration: 355.322102ms)","trace[721675335] 'applied index is now lower than readState.Index' (duration: 189.507449ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T11:03:21.892406Z","caller":"traceutil/trace.go:171","msg":"trace[756897737] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"545.606871ms","start":"2026-07-17T11:03:21.346776Z","end":"2026-07-17T11:03:21.892383Z","steps":["trace[756897737] 'process raft request' (duration: 530.0627ms)","trace[756897737] 'compare' (duration: 15.370607ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T11:03:21.892519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:03:21.346764Z","time spent":"545.684193ms","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T11:03:21.892537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.605232ms","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-17T11:03:21.892538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.042737ms","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-17T11:03:21.892571Z","caller":"traceutil/trace.go:171","msg":"trace[1814044283] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1053; }","duration":"518.644443ms","start":"2026-07-17T11:03:21.373915Z","end":"2026-07-17T11:03:21.89256Z","steps":["trace[1814044283] 'agreement among raft nodes before linearized reading' (duration: 518.52979ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:03:21.892582Z","caller":"traceutil/trace.go:171","msg":"trace[1091731686] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1053; }","duration":"545.100938ms","start":"2026-07-17T11:03:21.347469Z","end":"2026-07-17T11:03:21.89257Z","steps":["trace[1091731686] 'agreement among raft nodes before linearized reading' (duration: 544.941974ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:03:21.892601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:03:21.373867Z","time spent":"518.728145ms","remote":"127.0.0.1:51898","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-17T11:03:21.892612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:03:21.347453Z","time spent":"545.15202ms","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-17T11:03:21.892694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.679474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T11:03:21.892692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.393749ms","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-17T11:03:21.892721Z","caller":"traceutil/trace.go:171","msg":"trace[1107835457] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1053; }","duration":"433.727686ms","start":"2026-07-17T11:03:21.458985Z","end":"2026-07-17T11:03:21.892713Z","steps":["trace[1107835457] 'agreement among raft nodes before linearized reading' (duration: 433.688255ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:03:21.892726Z","caller":"traceutil/trace.go:171","msg":"trace[862300276] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1053; }","duration":"321.42778ms","start":"2026-07-17T11:03:21.57129Z","end":"2026-07-17T11:03:21.892718Z","steps":["trace[862300276] 'agreement among raft nodes before linearized reading' (duration: 321.329207ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:03:21.892744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:03:21.458973Z","time spent":"433.765666ms","remote":"127.0.0.1:51638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-17T11:03:21.892753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:03:21.571206Z","time spent":"321.541102ms","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-17T11:03:36.851526Z","caller":"traceutil/trace.go:171","msg":"trace[1980324] transaction","detail":"{read_only:false; response_revision:1154; number_of_response:1; }","duration":"166.014658ms","start":"2026-07-17T11:03:36.685487Z","end":"2026-07-17T11:03:36.851502Z","steps":["trace[1980324] 'process raft request' (duration: 165.866894ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:03:37.289043Z","caller":"traceutil/trace.go:171","msg":"trace[2140341385] linearizableReadLoop","detail":"{readStateIndex:1206; appliedIndex:1205; }","duration":"291.128107ms","start":"2026-07-17T11:03:36.99789Z","end":"2026-07-17T11:03:37.289018Z","steps":["trace[2140341385] 'read index received' (duration: 289.458935ms)","trace[2140341385] 'applied index is now lower than readState.Index' (duration: 1.668212ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T11:03:37.289197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.27734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T11:03:37.289241Z","caller":"traceutil/trace.go:171","msg":"trace[746756220] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1155; }","duration":"291.390133ms","start":"2026-07-17T11:03:36.997839Z","end":"2026-07-17T11:03:37.289229Z","steps":["trace[746756220] 'agreement among raft nodes before linearized reading' (duration: 291.27029ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:03:37.289373Z","caller":"traceutil/trace.go:171","msg":"trace[132408346] transaction","detail":"{read_only:false; response_revision:1155; number_of_response:1; }","duration":"418.194125ms","start":"2026-07-17T11:03:36.87115Z","end":"2026-07-17T11:03:37.289344Z","steps":["trace[132408346] 'process raft request' (duration: 416.273896ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:03:37.289512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:03:36.871126Z","time spent":"418.309177ms","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T11:03:54.033952Z","caller":"traceutil/trace.go:171","msg":"trace[187774787] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"199.770966ms","start":"2026-07-17T11:03:53.834157Z","end":"2026-07-17T11:03:54.033928Z","steps":["trace[187774787] 'process raft request' (duration: 199.645213ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:03:54.572194Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104474998847683,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-17T11:03:54.592452Z","caller":"traceutil/trace.go:171","msg":"trace[1905595856] linearizableReadLoop","detail":"{readStateIndex:1283; appliedIndex:1282; }","duration":"521.158943ms","start":"2026-07-17T11:03:54.071263Z","end":"2026-07-17T11:03:54.592422Z","steps":["trace[1905595856] 'read index received' (duration: 520.842965ms)","trace[1905595856] 'applied index is now lower than readState.Index' (duration: 314.808µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T11:03:54.592489Z","caller":"traceutil/trace.go:171","msg":"trace[866140647] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"554.804645ms","start":"2026-07-17T11:03:54.037658Z","end":"2026-07-17T11:03:54.592463Z","steps":["trace[866140647] 'process raft request' (duration: 554.60395ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:03:54.59262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:03:54.037637Z","time spent":"554.907698ms","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T11:03:54.5927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.40993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-17T11:03:54.592741Z","caller":"traceutil/trace.go:171","msg":"trace[2004914566] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1229; }","duration":"521.506372ms","start":"2026-07-17T11:03:54.071223Z","end":"2026-07-17T11:03:54.592729Z","steps":["trace[2004914566] 'agreement among raft nodes before linearized reading' (duration: 521.338897ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:03:54.592778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:03:54.071202Z","time spent":"521.567644ms","remote":"127.0.0.1:51898","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-17T11:03:54.592963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.132903ms","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-17T11:03:54.592964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.666661ms","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-17T11:03:54.592999Z","caller":"traceutil/trace.go:171","msg":"trace[594517977] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1229; }","duration":"451.232685ms","start":"2026-07-17T11:03:54.141757Z","end":"2026-07-17T11:03:54.59299Z","steps":["trace[594517977] 'agreement among raft nodes before linearized reading' (duration: 451.146363ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:03:54.593035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:03:54.141727Z","time spent":"451.300926ms","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-17T11:03:54.593061Z","caller":"traceutil/trace.go:171","msg":"trace[1969677189] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1229; }","duration":"456.933848ms","start":"2026-07-17T11:03:54.136107Z","end":"2026-07-17T11:03:54.593041Z","steps":["trace[1969677189] 'agreement among raft nodes before linearized reading' (duration: 456.559469ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:03:54.593564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:03:54.136081Z","time spent":"457.468512ms","remote":"127.0.0.1:51898","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-17T11:03:55.52677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.309691ms","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-17T11:03:55.526854Z","caller":"traceutil/trace.go:171","msg":"trace[1694119822] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1235; }","duration":"372.451515ms","start":"2026-07-17T11:03:55.154382Z","end":"2026-07-17T11:03:55.526834Z","steps":["trace[1694119822] 'range keys from in-memory index tree' (duration: 372.214698ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:03:55.526832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.736131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-07-17T11:03:55.526901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:03:55.15436Z","time spent":"372.530977ms","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-07-17T11:03:55.526919Z","caller":"traceutil/trace.go:171","msg":"trace[1529175257] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:1235; }","duration":"174.880545ms","start":"2026-07-17T11:03:55.352016Z","end":"2026-07-17T11:03:55.526897Z","steps":["trace[1529175257] 'range keys from in-memory index tree' (duration: 174.503865ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:03:56.071567Z","caller":"traceutil/trace.go:171","msg":"trace[355467393] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"528.684432ms","start":"2026-07-17T11:03:55.542865Z","end":"2026-07-17T11:03:56.071549Z","steps":["trace[355467393] 'process raft request' (duration: 528.649871ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:03:56.071627Z","caller":"traceutil/trace.go:171","msg":"trace[386510890] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"540.268041ms","start":"2026-07-17T11:03:55.531309Z","end":"2026-07-17T11:03:56.071577Z","steps":["trace[386510890] 'process raft request' (duration: 505.226735ms)","trace[386510890] 'compare' (duration: 34.889472ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T11:03:56.071661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:03:55.542855Z","time spent":"528.758053ms","remote":"127.0.0.1:51718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-17T11:03:56.071744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:03:55.531287Z","time spent":"540.398395ms","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":457,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T11:03:56.078402Z","caller":"traceutil/trace.go:171","msg":"trace[1180035683] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"377.1095ms","start":"2026-07-17T11:03:55.701277Z","end":"2026-07-17T11:03:56.078387Z","steps":["trace[1180035683] 'process raft request' (duration: 377.009867ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:03:56.078546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:03:55.701253Z","time spent":"377.235884ms","remote":"127.0.0.1:51686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T11:03:56.917263Z","caller":"traceutil/trace.go:171","msg":"trace[932561697] linearizableReadLoop","detail":"{readStateIndex:1299; appliedIndex:1298; }","duration":"291.52522ms","start":"2026-07-17T11:03:56.625712Z","end":"2026-07-17T11:03:56.917237Z","steps":["trace[932561697] 'read index received' (duration: 251.038547ms)","trace[932561697] 'applied index is now lower than readState.Index' (duration: 40.485163ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T11:03:56.917452Z","caller":"traceutil/trace.go:171","msg":"trace[1647700278] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"298.201788ms","start":"2026-07-17T11:03:56.619165Z","end":"2026-07-17T11:03:56.917367Z","steps":["trace[1647700278] 'process raft request' (duration: 257.729305ms)","trace[1647700278] 'compare' (duration: 39.98894ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T11:03:56.917683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.94376ms","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-17T11:03:56.917729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.851538ms","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-17T11:03:56.917814Z","caller":"traceutil/trace.go:171","msg":"trace[865426019] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1244; }","duration":"292.102204ms","start":"2026-07-17T11:03:56.62568Z","end":"2026-07-17T11:03:56.917782Z","steps":["trace[865426019] 'agreement among raft nodes before linearized reading' (duration: 291.814008ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:03:56.917819Z","caller":"traceutil/trace.go:171","msg":"trace[411407947] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1244; }","duration":"289.983352ms","start":"2026-07-17T11:03:56.627811Z","end":"2026-07-17T11:03:56.917795Z","steps":["trace[411407947] 'agreement among raft nodes before linearized reading' (duration: 289.677434ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:03:57.2254Z","caller":"traceutil/trace.go:171","msg":"trace[1732393684] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"302.64782ms","start":"2026-07-17T11:03:56.922709Z","end":"2026-07-17T11:03:57.225357Z","steps":["trace[1732393684] 'process raft request' (duration: 302.450215ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:03:57.225784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:03:56.922687Z","time spent":"302.806863ms","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T11:03:57.24405Z","caller":"traceutil/trace.go:171","msg":"trace[1632594960] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"321.15521ms","start":"2026-07-17T11:03:56.92288Z","end":"2026-07-17T11:03:57.244036Z","steps":["trace[1632594960] 'process raft request' (duration: 321.041798ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:03:57.24416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:03:56.922871Z","time spent":"321.216314ms","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T11:03:57.244497Z","caller":"traceutil/trace.go:171","msg":"trace[1668775306] linearizableReadLoop","detail":"{readStateIndex:1302; appliedIndex:1299; }","duration":"117.709624ms","start":"2026-07-17T11:03:57.126756Z","end":"2026-07-17T11:03:57.244466Z","steps":["trace[1668775306] 'read index received' (duration: 98.36895ms)","trace[1668775306] 'applied index is now lower than readState.Index' (duration: 19.338684ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T11:03:57.244664Z","caller":"traceutil/trace.go:171","msg":"trace[1839376389] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"260.124676ms","start":"2026-07-17T11:03:56.984509Z","end":"2026-07-17T11:03:57.244633Z","steps":["trace[1839376389] 'process raft request' (duration: 259.491ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:03:57.244671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.886017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T11:03:57.244764Z","caller":"traceutil/trace.go:171","msg":"trace[1480125273] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1247; }","duration":"118.061512ms","start":"2026-07-17T11:03:57.126693Z","end":"2026-07-17T11:03:57.244754Z","steps":["trace[1480125273] 'agreement among raft nodes before linearized reading' (duration: 117.900328ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:04:06.15578Z","caller":"traceutil/trace.go:171","msg":"trace[1117930515] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"155.92283ms","start":"2026-07-17T11:04:05.999812Z","end":"2026-07-17T11:04:06.155735Z","steps":["trace[1117930515] 'process raft request' (duration: 155.54477ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:04:06.797203Z","caller":"traceutil/trace.go:171","msg":"trace[1206707420] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"636.821537ms","start":"2026-07-17T11:04:06.160356Z","end":"2026-07-17T11:04:06.797177Z","steps":["trace[1206707420] 'process raft request' (duration: 636.688864ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:04:06.797376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:04:06.160334Z","time spent":"636.940049ms","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T11:04:06.848369Z","caller":"traceutil/trace.go:171","msg":"trace[998374787] linearizableReadLoop","detail":"{readStateIndex:1372; appliedIndex:1370; }","duration":"389.047159ms","start":"2026-07-17T11:04:06.459299Z","end":"2026-07-17T11:04:06.848346Z","steps":["trace[998374787] 'read index received' (duration: 337.731556ms)","trace[998374787] 'applied index is now lower than readState.Index' (duration: 51.314463ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T11:04:06.848559Z","caller":"traceutil/trace.go:171","msg":"trace[580057658] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"687.348159ms","start":"2026-07-17T11:04:06.16117Z","end":"2026-07-17T11:04:06.848518Z","steps":["trace[580057658] 'process raft request' (duration: 687.018921ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:04:06.848713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.903409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-17T11:04:06.848738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.421739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T11:04:06.848784Z","caller":"traceutil/trace.go:171","msg":"trace[1137308429] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1315; }","duration":"164.037823ms","start":"2026-07-17T11:04:06.684729Z","end":"2026-07-17T11:04:06.848767Z","steps":["trace[1137308429] 'agreement among raft nodes before linearized reading' (duration: 163.822347ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:04:06.848808Z","caller":"traceutil/trace.go:171","msg":"trace[944571657] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1315; }","duration":"389.539211ms","start":"2026-07-17T11:04:06.459251Z","end":"2026-07-17T11:04:06.84879Z","steps":["trace[944571657] 'agreement among raft nodes before linearized reading' (duration: 389.432259ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:04:06.848722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:04:06.16114Z","time spent":"687.470293ms","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":457,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T11:04:06.848848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:04:06.459229Z","time spent":"389.612094ms","remote":"127.0.0.1:51636","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-17T11:04:06.967902Z","caller":"traceutil/trace.go:171","msg":"trace[2027820314] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"113.056748ms","start":"2026-07-17T11:04:06.854823Z","end":"2026-07-17T11:04:06.96788Z","steps":["trace[2027820314] 'process raft request' (duration: 107.693873ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:05:30.536169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.376743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-07-17T11:05:30.536279Z","caller":"traceutil/trace.go:171","msg":"trace[398419238] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1699; }","duration":"269.608839ms","start":"2026-07-17T11:05:30.266652Z","end":"2026-07-17T11:05:30.536261Z","steps":["trace[398419238] 'range keys from in-memory index tree' (duration: 268.844969ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:05:36.219106Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104474998848862,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T11:05:36.720291Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104474998848862,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T11:05:37.220523Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104474998848862,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T11:05:37.721438Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104474998848862,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T11:05:38.223842Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104474998848862,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T11:05:38.462583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00099482s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-17T11:05:38.462691Z","caller":"traceutil/trace.go:171","msg":"trace[2029950145] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001185625s","start":"2026-07-17T11:05:36.461489Z","end":"2026-07-17T11:05:38.462675Z","steps":["trace[2029950145] 'agreement among raft nodes before linearized reading' (duration: 2.001051002s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:05:38.462731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:05:36.461453Z","time spent":"2.001270757s","remote":"127.0.0.1:51638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-17T11:05:38.725404Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104474998848862,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T11:05:39.225963Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104474998848862,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T11:05:39.726255Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104474998848862,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T11:05:40.00687Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"4.454778278s","expected-duration":"1s"} {"level":"info","ts":"2026-07-17T11:05:40.007477Z","caller":"traceutil/trace.go:171","msg":"trace[54903999] transaction","detail":"{read_only:false; response_revision:1724; number_of_response:1; }","duration":"4.455498126s","start":"2026-07-17T11:05:35.551947Z","end":"2026-07-17T11:05:40.007446Z","steps":["trace[54903999] 'process raft request' (duration: 4.455291371s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:05:40.007694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:05:35.551932Z","time spent":"4.45563619s","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":519,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T11:05:40.01045Z","caller":"traceutil/trace.go:171","msg":"trace[1713011774] linearizableReadLoop","detail":"{readStateIndex:1801; appliedIndex:1799; }","duration":"4.291668034s","start":"2026-07-17T11:05:35.718748Z","end":"2026-07-17T11:05:40.010416Z","steps":["trace[1713011774] 'read index received' (duration: 4.289097379s)","trace[1713011774] 'applied index is now lower than readState.Index' (duration: 2.568975ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T11:05:40.010496Z","caller":"traceutil/trace.go:171","msg":"trace[1185810391] transaction","detail":"{read_only:false; response_revision:1726; number_of_response:1; }","duration":"525.084734ms","start":"2026-07-17T11:05:39.485375Z","end":"2026-07-17T11:05:40.01046Z","steps":["trace[1185810391] 'process raft request' (duration: 524.97806ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:05:40.010642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:05:39.485341Z","time spent":"525.219337ms","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T11:05:40.010834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"952.31504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T11:05:40.010921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.770797677s","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-17T11:05:40.010963Z","caller":"traceutil/trace.go:171","msg":"trace[60709336] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1726; }","duration":"2.77088365s","start":"2026-07-17T11:05:37.240066Z","end":"2026-07-17T11:05:40.01095Z","steps":["trace[60709336] 'agreement among raft nodes before linearized reading' (duration: 2.770715946s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:05:40.011004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:05:37.240048Z","time spent":"2.770948252s","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-17T11:05:40.011053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.585977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T11:05:40.011089Z","caller":"traceutil/trace.go:171","msg":"trace[1628718893] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1726; }","duration":"682.680261ms","start":"2026-07-17T11:05:39.328399Z","end":"2026-07-17T11:05:40.011079Z","steps":["trace[1628718893] 'agreement among raft nodes before linearized reading' (duration: 682.613568ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:05:40.01111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.728023796s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T11:05:40.011129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:05:39.328375Z","time spent":"682.744733ms","remote":"127.0.0.1:52032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"info","ts":"2026-07-17T11:05:40.011148Z","caller":"traceutil/trace.go:171","msg":"trace[1128447183] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1726; }","duration":"1.728063797s","start":"2026-07-17T11:05:38.283073Z","end":"2026-07-17T11:05:40.011136Z","steps":["trace[1128447183] 'agreement among raft nodes before linearized reading' (duration: 1.728002915s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:05:40.011127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.285347734s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-17T11:05:40.011186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:05:38.283003Z","time spent":"1.7281749s","remote":"127.0.0.1:45672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"info","ts":"2026-07-17T11:05:40.01128Z","caller":"traceutil/trace.go:171","msg":"trace[592797264] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1726; }","duration":"4.28560461s","start":"2026-07-17T11:05:35.725593Z","end":"2026-07-17T11:05:40.011198Z","steps":["trace[592797264] 'agreement among raft nodes before linearized reading' (duration: 4.285040626s)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:05:40.010964Z","caller":"traceutil/trace.go:171","msg":"trace[1244979829] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1726; }","duration":"952.479454ms","start":"2026-07-17T11:05:39.058461Z","end":"2026-07-17T11:05:40.01094Z","steps":["trace[1244979829] 'agreement among raft nodes before linearized reading' (duration: 952.237889ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:05:40.011306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.548771245s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T11:05:40.011365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.61359074s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-17T11:05:40.011392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:05:39.058389Z","time spent":"952.988657ms","remote":"127.0.0.1:59160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"info","ts":"2026-07-17T11:05:40.011417Z","caller":"traceutil/trace.go:171","msg":"trace[1061791331] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1726; }","duration":"1.54894848s","start":"2026-07-17T11:05:38.46244Z","end":"2026-07-17T11:05:40.011388Z","steps":["trace[1061791331] 'agreement among raft nodes before linearized reading' (duration: 1.548235332s)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:05:40.011436Z","caller":"traceutil/trace.go:171","msg":"trace[258790320] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1726; }","duration":"2.613701313s","start":"2026-07-17T11:05:37.397716Z","end":"2026-07-17T11:05:40.011417Z","steps":["trace[258790320] 'agreement among raft nodes before linearized reading' (duration: 2.613528228s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:05:40.011452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.865427493s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:525"} {"level":"warn","ts":"2026-07-17T11:05:40.01147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:05:38.462403Z","time spent":"1.549057912s","remote":"127.0.0.1:51636","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-17T11:05:40.011498Z","caller":"traceutil/trace.go:171","msg":"trace[1650059971] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1726; }","duration":"2.865513785s","start":"2026-07-17T11:05:37.145966Z","end":"2026-07-17T11:05:40.011479Z","steps":["trace[1650059971] 'agreement among raft nodes before linearized reading' (duration: 2.865402322s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:05:40.011496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:05:37.397692Z","time spent":"2.613789365s","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-17T11:05:40.011528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:05:37.145941Z","time spent":"2.865580367s","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":548,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-17T11:05:40.01134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:05:35.725582Z","time spent":"4.285743283s","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-17T11:05:40.011574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.138855983s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-17T11:05:40.011612Z","caller":"traceutil/trace.go:171","msg":"trace[1679376617] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1726; }","duration":"1.138954626s","start":"2026-07-17T11:05:38.872647Z","end":"2026-07-17T11:05:40.011601Z","steps":["trace[1679376617] 'agreement among raft nodes before linearized reading' (duration: 1.138879284s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:05:40.011643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:05:38.872618Z","time spent":"1.139017447s","remote":"127.0.0.1:52048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-07-17T11:05:40.011711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.991903239s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"info","ts":"2026-07-17T11:05:40.011742Z","caller":"traceutil/trace.go:171","msg":"trace[740858563] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1726; }","duration":"2.991981771s","start":"2026-07-17T11:05:37.019751Z","end":"2026-07-17T11:05:40.011732Z","steps":["trace[740858563] 'agreement among raft nodes before linearized reading' (duration: 2.991899318s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:05:40.011772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:05:37.019723Z","time spent":"2.992038023s","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":495,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-17T11:05:40.011826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.000912041s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T11:05:40.011836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.249073271s","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:509"} {"level":"info","ts":"2026-07-17T11:05:40.011863Z","caller":"traceutil/trace.go:171","msg":"trace[375899310] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1726; }","duration":"1.000966292s","start":"2026-07-17T11:05:39.010881Z","end":"2026-07-17T11:05:40.011848Z","steps":["trace[375899310] 'agreement among raft nodes before linearized reading' (duration: 1.00091473s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:05:40.01189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.398855717s","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-17T11:05:40.011898Z","caller":"traceutil/trace.go:171","msg":"trace[1272595099] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1726; }","duration":"1.249182053s","start":"2026-07-17T11:05:38.762691Z","end":"2026-07-17T11:05:40.011873Z","steps":["trace[1272595099] 'agreement among raft nodes before linearized reading' (duration: 1.249005288s)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:05:40.011922Z","caller":"traceutil/trace.go:171","msg":"trace[663894306] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1726; }","duration":"3.398930268s","start":"2026-07-17T11:05:36.612983Z","end":"2026-07-17T11:05:40.011913Z","steps":["trace[663894306] 'agreement among raft nodes before linearized reading' (duration: 3.398849806s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:05:40.011944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:05:38.762662Z","time spent":"1.249270756s","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-17T11:05:40.01195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:05:36.612951Z","time spent":"3.39899362s","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-07-17T11:05:40.011843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.600767279s","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-17T11:05:40.012056Z","caller":"traceutil/trace.go:171","msg":"trace[570134739] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1726; }","duration":"2.601038785s","start":"2026-07-17T11:05:37.411004Z","end":"2026-07-17T11:05:40.012043Z","steps":["trace[570134739] 'agreement among raft nodes before linearized reading' (duration: 2.600750709s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:05:40.011902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:05:39.01087Z","time spent":"1.001024283s","remote":"127.0.0.1:59084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-17T11:05:40.012107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:05:37.41098Z","time spent":"2.601116328s","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-17T11:05:40.012148Z","caller":"traceutil/trace.go:171","msg":"trace[1858817062] transaction","detail":"{read_only:false; response_revision:1725; number_of_response:1; }","duration":"4.412733052s","start":"2026-07-17T11:05:35.599393Z","end":"2026-07-17T11:05:40.012126Z","steps":["trace[1858817062] 'process raft request' (duration: 4.410593889s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:05:40.01229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:05:35.599355Z","time spent":"4.412842435s","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T11:05:40.012749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.293999262s","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-17T11:05:40.012828Z","caller":"traceutil/trace.go:171","msg":"trace[773383000] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1726; }","duration":"4.294122294s","start":"2026-07-17T11:05:35.718691Z","end":"2026-07-17T11:05:40.012814Z","steps":["trace[773383000] 'agreement among raft nodes before linearized reading' (duration: 4.291847258s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:05:40.01286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:05:35.718653Z","time spent":"4.294200156s","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}