{"level":"warn","ts":"2026-06-08T18:50:48.805018Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-08T18:50:48.805109Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.223:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.223:2380","--initial-cluster=instance=https://199.19.213.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.223: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-06-08T18:50:48.805191Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-08T18:50:48.805208Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.223:2380"]} {"level":"info","ts":"2026-06-08T18:50:48.805235Z","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-06-08T18:50:48.805921Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.223:2379"]} {"level":"info","ts":"2026-06-08T18:50:48.805992Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.223:2380"],"listen-peer-urls":["https://199.19.213.223:2380"],"advertise-client-urls":["https://199.19.213.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.223: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-06-08T18:50:49.185496Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"379.327226ms"} {"level":"info","ts":"2026-06-08T18:50:49.863355Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"12dd93b2fab6fcb","cluster-id":"8ac3bdb9c2c26b53"} {"level":"info","ts":"2026-06-08T18:50:49.863574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb switched to configuration voters=()"} {"level":"info","ts":"2026-06-08T18:50:49.863666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb became follower at term 0"} {"level":"info","ts":"2026-06-08T18:50:49.863716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 12dd93b2fab6fcb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-08T18:50:49.863758Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb became follower at term 1"} {"level":"info","ts":"2026-06-08T18:50:49.863847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb switched to configuration voters=(84962816215969739)"} {"level":"warn","ts":"2026-06-08T18:50:49.865877Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-08T18:50:49.867877Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-08T18:50:49.869526Z","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-06-08T18:50:49.872238Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"12dd93b2fab6fcb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-08T18:50:49.872572Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"12dd93b2fab6fcb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-08T18:50:49.873019Z","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-06-08T18:50:49.87371Z","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-06-08T18:50:49.87378Z","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-06-08T18:50:49.876055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb switched to configuration voters=(84962816215969739)"} {"level":"info","ts":"2026-06-08T18:50:49.876271Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8ac3bdb9c2c26b53","local-member-id":"12dd93b2fab6fcb","added-peer-id":"12dd93b2fab6fcb","added-peer-peer-urls":["https://199.19.213.223:2380"]} {"level":"info","ts":"2026-06-08T18:50:49.877761Z","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-06-08T18:50:49.877924Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.223:2380"} {"level":"info","ts":"2026-06-08T18:50:49.877984Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.223:2380"} {"level":"info","ts":"2026-06-08T18:50:49.878129Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"12dd93b2fab6fcb","initial-advertise-peer-urls":["https://199.19.213.223:2380"],"listen-peer-urls":["https://199.19.213.223:2380"],"advertise-client-urls":["https://199.19.213.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-08T18:50:49.878201Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-08T18:50:50.464364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb is starting a new election at term 1"} {"level":"info","ts":"2026-06-08T18:50:50.464422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb became pre-candidate at term 1"} {"level":"info","ts":"2026-06-08T18:50:50.464465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb received MsgPreVoteResp from 12dd93b2fab6fcb at term 1"} {"level":"info","ts":"2026-06-08T18:50:50.464484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb became candidate at term 2"} {"level":"info","ts":"2026-06-08T18:50:50.464496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb received MsgVoteResp from 12dd93b2fab6fcb at term 2"} {"level":"info","ts":"2026-06-08T18:50:50.464512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"12dd93b2fab6fcb became leader at term 2"} {"level":"info","ts":"2026-06-08T18:50:50.464526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 12dd93b2fab6fcb elected leader 12dd93b2fab6fcb at term 2"} {"level":"info","ts":"2026-06-08T18:50:50.465796Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"12dd93b2fab6fcb","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.223:2379]}","request-path":"/0/members/12dd93b2fab6fcb/attributes","cluster-id":"8ac3bdb9c2c26b53","publish-timeout":"7s"} {"level":"info","ts":"2026-06-08T18:50:50.465843Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-08T18:50:50.465902Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T18:50:50.465939Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-08T18:50:50.466115Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-08T18:50:50.466166Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-08T18:50:50.46736Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8ac3bdb9c2c26b53","local-member-id":"12dd93b2fab6fcb","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T18:50:50.467509Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T18:50:50.467551Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T18:50:50.468995Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-08T18:50:50.469537Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.223:2379"} {"level":"warn","ts":"2026-06-08T18:51:23.865649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.558469ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T18:51:23.865794Z","caller":"traceutil/trace.go:171","msg":"trace[496434569] linearizableReadLoop","detail":"{readStateIndex:497; appliedIndex:496; }","duration":"240.124586ms","start":"2026-06-08T18:51:23.625652Z","end":"2026-06-08T18:51:23.865777Z","steps":["trace[496434569] 'read index received' (duration: 96.815734ms)","trace[496434569] 'applied index is now lower than readState.Index' (duration: 143.307592ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:51:23.865831Z","caller":"traceutil/trace.go:171","msg":"trace[695463405] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"289.635665ms","start":"2026-06-08T18:51:23.576171Z","end":"2026-06-08T18:51:23.865806Z","steps":["trace[695463405] 'process raft request' (duration: 146.316802ms)","trace[695463405] 'compare' (duration: 142.445656ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:51:23.866002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.89407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12669"} {"level":"info","ts":"2026-06-08T18:51:23.866034Z","caller":"traceutil/trace.go:171","msg":"trace[1163403790] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:479; }","duration":"211.971231ms","start":"2026-06-08T18:51:23.654053Z","end":"2026-06-08T18:51:23.866024Z","steps":["trace[1163403790] 'agreement among raft nodes before linearized reading' (duration: 211.847689ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:51:23.86603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.372701ms","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-06-08T18:51:23.866079Z","caller":"traceutil/trace.go:171","msg":"trace[1153176957] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:479; }","duration":"240.451113ms","start":"2026-06-08T18:51:23.625614Z","end":"2026-06-08T18:51:23.866065Z","steps":["trace[1153176957] 'agreement among raft nodes before linearized reading' (duration: 240.28429ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:51:24.110717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.729177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12669"} {"level":"info","ts":"2026-06-08T18:51:24.110794Z","caller":"traceutil/trace.go:171","msg":"trace[1515618273] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:480; }","duration":"103.84753ms","start":"2026-06-08T18:51:24.006929Z","end":"2026-06-08T18:51:24.110777Z","steps":["trace[1515618273] 'range keys from in-memory index tree' (duration: 103.633465ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:51:24.460437Z","caller":"traceutil/trace.go:171","msg":"trace[2110246719] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"311.861595ms","start":"2026-06-08T18:51:24.148538Z","end":"2026-06-08T18:51:24.4604Z","steps":["trace[2110246719] 'process raft request' (duration: 311.523469ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:51:24.460631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:51:24.148522Z","time spent":"311.999718ms","remote":"127.0.0.1:42964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T18:51:28.005173Z","caller":"traceutil/trace.go:171","msg":"trace[1868067269] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"100.464483ms","start":"2026-06-08T18:51:27.904664Z","end":"2026-06-08T18:51:28.005129Z","steps":["trace[1868067269] 'process raft request' (duration: 99.367753ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:51:28.824173Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8055706805335919860,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-08T18:51:28.882427Z","caller":"traceutil/trace.go:171","msg":"trace[408069786] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"577.855503ms","start":"2026-06-08T18:51:28.304556Z","end":"2026-06-08T18:51:28.882412Z","steps":["trace[408069786] 'process raft request' (duration: 568.187346ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:51:28.882536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:51:28.30454Z","time spent":"577.939484ms","remote":"127.0.0.1:42756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4059,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T18:51:28.882668Z","caller":"traceutil/trace.go:171","msg":"trace[999285095] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"577.988955ms","start":"2026-06-08T18:51:28.304648Z","end":"2026-06-08T18:51:28.882637Z","steps":["trace[999285095] 'process raft request' (duration: 577.635739ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:51:28.88278Z","caller":"traceutil/trace.go:171","msg":"trace[44806512] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"476.380438ms","start":"2026-06-08T18:51:28.406381Z","end":"2026-06-08T18:51:28.882761Z","steps":["trace[44806512] 'process raft request' (duration: 476.015172ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:51:28.882828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:51:28.30454Z","time spent":"578.207819ms","remote":"127.0.0.1:43172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4387,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T18:51:28.883121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:51:28.406363Z","time spent":"476.449599ms","remote":"127.0.0.1:42756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-08T18:51:28.885313Z","caller":"traceutil/trace.go:171","msg":"trace[24608298] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:633; }","duration":"561.951045ms","start":"2026-06-08T18:51:28.323339Z","end":"2026-06-08T18:51:28.88529Z","steps":["trace[24608298] 'read index received' (duration: 549.447943ms)","trace[24608298] 'applied index is now lower than readState.Index' (duration: 12.501972ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:51:28.885317Z","caller":"traceutil/trace.go:171","msg":"trace[1817159334] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"401.911418ms","start":"2026-06-08T18:51:28.483384Z","end":"2026-06-08T18:51:28.885296Z","steps":["trace[1817159334] 'process raft request' (duration: 401.5081ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:51:28.885432Z","caller":"traceutil/trace.go:171","msg":"trace[194797231] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"277.960739ms","start":"2026-06-08T18:51:28.607461Z","end":"2026-06-08T18:51:28.885421Z","steps":["trace[194797231] 'process raft request' (duration: 277.759105ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:51:28.885495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:51:28.483352Z","time spent":"402.044561ms","remote":"127.0.0.1:42756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T18:51:28.885836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.550032ms","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-06-08T18:51:28.886042Z","caller":"traceutil/trace.go:171","msg":"trace[210815580] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:618; }","duration":"414.763137ms","start":"2026-06-08T18:51:28.471208Z","end":"2026-06-08T18:51:28.885971Z","steps":["trace[210815580] 'agreement among raft nodes before linearized reading' (duration: 414.40813ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:51:28.88592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.565297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:80703"} {"level":"warn","ts":"2026-06-08T18:51:28.886108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:51:28.471191Z","time spent":"414.90224ms","remote":"127.0.0.1:42964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-08T18:51:28.886142Z","caller":"traceutil/trace.go:171","msg":"trace[769163315] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:618; }","duration":"562.787831ms","start":"2026-06-08T18:51:28.323335Z","end":"2026-06-08T18:51:28.886123Z","steps":["trace[769163315] 'agreement among raft nodes before linearized reading' (duration: 562.416023ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:51:28.886194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:51:28.323291Z","time spent":"562.889223ms","remote":"127.0.0.1:42756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":1,"response size":80726,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-06-08T18:51:29.741672Z","caller":"traceutil/trace.go:171","msg":"trace[1515108198] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"113.944816ms","start":"2026-06-08T18:51:29.627701Z","end":"2026-06-08T18:51:29.741646Z","steps":["trace[1515108198] 'process raft request' (duration: 113.806103ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:51:36.026378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.143537ms","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-06-08T18:51:36.026462Z","caller":"traceutil/trace.go:171","msg":"trace[1538916737] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:688; }","duration":"270.312881ms","start":"2026-06-08T18:51:35.756131Z","end":"2026-06-08T18:51:36.026444Z","steps":["trace[1538916737] 'range keys from in-memory index tree' (duration: 269.889102ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:51:36.026998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"743.601821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5db2w\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-06-08T18:51:36.027015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.063868369s","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-06-08T18:51:36.027091Z","caller":"traceutil/trace.go:171","msg":"trace[561027990] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5db2w; range_end:; response_count:1; response_revision:688; }","duration":"743.744973ms","start":"2026-06-08T18:51:35.283325Z","end":"2026-06-08T18:51:36.02707Z","steps":["trace[561027990] 'range keys from in-memory index tree' (duration: 743.368126ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:51:36.027114Z","caller":"traceutil/trace.go:171","msg":"trace[450077617] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:688; }","duration":"1.06398314s","start":"2026-06-08T18:51:34.963105Z","end":"2026-06-08T18:51:36.027089Z","steps":["trace[450077617] 'range keys from in-memory index tree' (duration: 1.063509732s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:51:36.027141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:51:35.283308Z","time spent":"743.823645ms","remote":"127.0.0.1:42904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-5db2w\" "} {"level":"warn","ts":"2026-06-08T18:51:36.027157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:51:34.963089Z","time spent":"1.064058702s","remote":"127.0.0.1:42964","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-06-08T18:51:36.027349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.0660519s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-08T18:51:36.02754Z","caller":"traceutil/trace.go:171","msg":"trace[1424600531] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:688; }","duration":"1.066302275s","start":"2026-06-08T18:51:34.961207Z","end":"2026-06-08T18:51:36.027509Z","steps":["trace[1424600531] 'range keys from in-memory index tree' (duration: 1.065583882s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:51:36.027679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:51:34.961184Z","time spent":"1.066437697s","remote":"127.0.0.1:42964","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-06-08T18:51:36.02692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.088940534s","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-06-08T18:51:36.02814Z","caller":"traceutil/trace.go:171","msg":"trace[1225703516] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:688; }","duration":"1.090583586s","start":"2026-06-08T18:51:34.937539Z","end":"2026-06-08T18:51:36.028123Z","steps":["trace[1225703516] 'range keys from in-memory index tree' (duration: 1.088579546s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:51:36.028183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:51:34.937488Z","time spent":"1.090681067s","remote":"127.0.0.1:42964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-08T18:51:36.17468Z","caller":"traceutil/trace.go:171","msg":"trace[655687223] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"142.087149ms","start":"2026-06-08T18:51:36.032572Z","end":"2026-06-08T18:51:36.17466Z","steps":["trace[655687223] 'process raft request' (duration: 141.918076ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:51:36.175072Z","caller":"traceutil/trace.go:171","msg":"trace[1306434650] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"142.304594ms","start":"2026-06-08T18:51:36.03274Z","end":"2026-06-08T18:51:36.175045Z","steps":["trace[1306434650] 'process raft request' (duration: 141.885375ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:51:36.175244Z","caller":"traceutil/trace.go:171","msg":"trace[179158884] linearizableReadLoop","detail":"{readStateIndex:716; appliedIndex:711; }","duration":"125.631852ms","start":"2026-06-08T18:51:36.049571Z","end":"2026-06-08T18:51:36.175203Z","steps":["trace[179158884] 'read index received' (duration: 71.136477ms)","trace[179158884] 'applied index is now lower than readState.Index' (duration: 54.493515ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:51:36.175572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.978618ms","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-06-08T18:51:36.175638Z","caller":"traceutil/trace.go:171","msg":"trace[58857767] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:694; }","duration":"126.1036ms","start":"2026-06-08T18:51:36.049506Z","end":"2026-06-08T18:51:36.17561Z","steps":["trace[58857767] 'agreement among raft nodes before linearized reading' (duration: 125.840496ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:51:36.175657Z","caller":"traceutil/trace.go:171","msg":"trace[1492903418] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"142.751643ms","start":"2026-06-08T18:51:36.032886Z","end":"2026-06-08T18:51:36.175638Z","steps":["trace[1492903418] 'process raft request' (duration: 142.011048ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:51:36.17578Z","caller":"traceutil/trace.go:171","msg":"trace[1248425727] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"134.054715ms","start":"2026-06-08T18:51:36.041523Z","end":"2026-06-08T18:51:36.175578Z","steps":["trace[1248425727] 'process raft request' (duration: 133.533625ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:51:38.607246Z","caller":"traceutil/trace.go:171","msg":"trace[2040894521] linearizableReadLoop","detail":"{readStateIndex:719; appliedIndex:718; }","duration":"425.83835ms","start":"2026-06-08T18:51:38.18139Z","end":"2026-06-08T18:51:38.607229Z","steps":["trace[2040894521] 'read index received' (duration: 425.675617ms)","trace[2040894521] 'applied index is now lower than readState.Index' (duration: 162.193µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:51:38.607426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.020255ms","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-06-08T18:51:38.607457Z","caller":"traceutil/trace.go:171","msg":"trace[1145889420] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:696; }","duration":"426.068165ms","start":"2026-06-08T18:51:38.181382Z","end":"2026-06-08T18:51:38.60745Z","steps":["trace[1145889420] 'agreement among raft nodes before linearized reading' (duration: 425.933473ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:51:38.607489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:51:38.181226Z","time spent":"426.25449ms","remote":"127.0.0.1:42964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-08T18:51:38.607529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.82897ms","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-06-08T18:51:38.607611Z","caller":"traceutil/trace.go:171","msg":"trace[1674249631] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:696; }","duration":"425.964463ms","start":"2026-06-08T18:51:38.181631Z","end":"2026-06-08T18:51:38.607596Z","steps":["trace[1674249631] 'agreement among raft nodes before linearized reading' (duration: 425.728919ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:51:38.607663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:51:38.181609Z","time spent":"426.044924ms","remote":"127.0.0.1:42964","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":"warn","ts":"2026-06-08T18:51:38.607648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.303928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-08T18:51:38.607684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.06736ms","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-06-08T18:51:38.607751Z","caller":"traceutil/trace.go:171","msg":"trace[836278814] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:696; }","duration":"321.454321ms","start":"2026-06-08T18:51:38.286268Z","end":"2026-06-08T18:51:38.607722Z","steps":["trace[836278814] 'agreement among raft nodes before linearized reading' (duration: 321.283498ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:51:38.607804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:51:38.286246Z","time spent":"321.549813ms","remote":"127.0.0.1:42724","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-06-08T18:51:38.607829Z","caller":"traceutil/trace.go:171","msg":"trace[1900846675] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:696; }","duration":"403.244824ms","start":"2026-06-08T18:51:38.204536Z","end":"2026-06-08T18:51:38.60778Z","steps":["trace[1900846675] 'agreement among raft nodes before linearized reading' (duration: 402.835266ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:51:38.607915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.180587ms","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-06-08T18:51:38.607925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:51:38.204524Z","time spent":"403.384996ms","remote":"127.0.0.1:42964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-08T18:51:38.608051Z","caller":"traceutil/trace.go:171","msg":"trace[394023380] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:696; }","duration":"426.322189ms","start":"2026-06-08T18:51:38.181715Z","end":"2026-06-08T18:51:38.608037Z","steps":["trace[394023380] 'agreement among raft nodes before linearized reading' (duration: 425.873991ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:51:38.607795Z","caller":"traceutil/trace.go:171","msg":"trace[1004292506] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"476.187586ms","start":"2026-06-08T18:51:38.131108Z","end":"2026-06-08T18:51:38.607295Z","steps":["trace[1004292506] 'process raft request' (duration: 476.017792ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:51:38.608113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:51:38.181653Z","time spent":"426.450303ms","remote":"127.0.0.1:42964","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-06-08T18:51:38.608158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:51:38.13108Z","time spent":"477.022601ms","remote":"127.0.0.1:42964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T18:51:53.381414Z","caller":"traceutil/trace.go:171","msg":"trace[215767276] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"111.805544ms","start":"2026-06-08T18:51:53.26958Z","end":"2026-06-08T18:51:53.381386Z","steps":["trace[215767276] 'process raft request' (duration: 111.646861ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:51:54.490421Z","caller":"traceutil/trace.go:171","msg":"trace[8613519] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"224.652778ms","start":"2026-06-08T18:51:54.265722Z","end":"2026-06-08T18:51:54.490374Z","steps":["trace[8613519] 'process raft request' (duration: 151.146894ms)","trace[8613519] 'compare' (duration: 73.33122ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:51:54.689314Z","caller":"traceutil/trace.go:171","msg":"trace[1558556750] linearizableReadLoop","detail":"{readStateIndex:832; appliedIndex:831; }","duration":"160.790662ms","start":"2026-06-08T18:51:54.528502Z","end":"2026-06-08T18:51:54.689293Z","steps":["trace[1558556750] 'read index received' (duration: 133.172017ms)","trace[1558556750] 'applied index is now lower than readState.Index' (duration: 27.617795ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:51:54.689485Z","caller":"traceutil/trace.go:171","msg":"trace[1672137154] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"191.552247ms","start":"2026-06-08T18:51:54.49789Z","end":"2026-06-08T18:51:54.689442Z","steps":["trace[1672137154] 'process raft request' (duration: 163.867791ms)","trace[1672137154] 'compare' (duration: 27.450032ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:51:54.689558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.014476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:1 size:1642"} {"level":"info","ts":"2026-06-08T18:51:54.689702Z","caller":"traceutil/trace.go:171","msg":"trace[1519937074] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:1; response_revision:803; }","duration":"161.196959ms","start":"2026-06-08T18:51:54.528489Z","end":"2026-06-08T18:51:54.689686Z","steps":["trace[1519937074] 'agreement among raft nodes before linearized reading' (duration: 160.893164ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:51:55.011005Z","caller":"traceutil/trace.go:171","msg":"trace[1598385975] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"251.844863ms","start":"2026-06-08T18:51:54.75913Z","end":"2026-06-08T18:51:55.010975Z","steps":["trace[1598385975] 'process raft request' (duration: 216.487409ms)","trace[1598385975] 'compare' (duration: 35.14332ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:51:55.011571Z","caller":"traceutil/trace.go:171","msg":"trace[1091277204] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"250.591319ms","start":"2026-06-08T18:51:54.760953Z","end":"2026-06-08T18:51:55.011544Z","steps":["trace[1091277204] 'process raft request' (duration: 250.541548ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:51:55.011689Z","caller":"traceutil/trace.go:171","msg":"trace[1730482716] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"252.371994ms","start":"2026-06-08T18:51:54.759275Z","end":"2026-06-08T18:51:55.011647Z","steps":["trace[1730482716] 'process raft request' (duration: 252.008777ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:51:55.011456Z","caller":"traceutil/trace.go:171","msg":"trace[523925247] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"252.266392ms","start":"2026-06-08T18:51:54.75916Z","end":"2026-06-08T18:51:55.011426Z","steps":["trace[523925247] 'process raft request' (duration: 251.769853ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:51:56.23438Z","caller":"traceutil/trace.go:171","msg":"trace[1400959727] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"537.780954ms","start":"2026-06-08T18:51:55.696571Z","end":"2026-06-08T18:51:56.234352Z","steps":["trace[1400959727] 'process raft request' (duration: 537.417537ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:51:56.234564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:51:55.69655Z","time spent":"537.913906ms","remote":"127.0.0.1:42944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T18:51:56.854481Z","caller":"traceutil/trace.go:171","msg":"trace[1366103816] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"397.468241ms","start":"2026-06-08T18:51:56.45698Z","end":"2026-06-08T18:51:56.854449Z","steps":["trace[1366103816] 'process raft request' (duration: 397.284498ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:51:56.854663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:51:56.456953Z","time spent":"397.624705ms","remote":"127.0.0.1:42900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5052,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T18:51:56.856271Z","caller":"traceutil/trace.go:171","msg":"trace[171685556] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"183.324972ms","start":"2026-06-08T18:51:56.672915Z","end":"2026-06-08T18:51:56.85624Z","steps":["trace[171685556] 'process raft request' (duration: 183.036266ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:52:01.110896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.075903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050264"} {"level":"info","ts":"2026-06-08T18:52:01.111048Z","caller":"traceutil/trace.go:171","msg":"trace[1326758571] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:864; }","duration":"132.289837ms","start":"2026-06-08T18:52:00.978728Z","end":"2026-06-08T18:52:01.111018Z","steps":["trace[1326758571] 'range keys from in-memory index tree' (duration: 125.24389ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:52:31.73956Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8055706805335920803,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-08T18:52:31.805765Z","caller":"traceutil/trace.go:171","msg":"trace[220836184] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"783.317798ms","start":"2026-06-08T18:52:31.022418Z","end":"2026-06-08T18:52:31.805736Z","steps":["trace[220836184] 'process raft request' (duration: 783.163495ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:52:31.805956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:52:31.022394Z","time spent":"783.47797ms","remote":"127.0.0.1:42964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T18:52:32.71184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.089315ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T18:52:32.712356Z","caller":"traceutil/trace.go:171","msg":"trace[2016301413] linearizableReadLoop","detail":"{readStateIndex:1064; appliedIndex:1062; }","duration":"1.473526697s","start":"2026-06-08T18:52:31.238798Z","end":"2026-06-08T18:52:32.712324Z","steps":["trace[2016301413] 'read index received' (duration: 566.890215ms)","trace[2016301413] 'applied index is now lower than readState.Index' (duration: 906.633332ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:52:32.712557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.105909403s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T18:52:32.7126Z","caller":"traceutil/trace.go:171","msg":"trace[1805788362] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1028; }","duration":"1.105999404s","start":"2026-06-08T18:52:31.606587Z","end":"2026-06-08T18:52:32.712587Z","steps":["trace[1805788362] 'agreement among raft nodes before linearized reading' (duration: 1.105909782s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:52:32.712613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.459940465s","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-06-08T18:52:32.71265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.459385965s","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-06-08T18:52:32.712675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.661964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T18:52:32.71269Z","caller":"traceutil/trace.go:171","msg":"trace[250479395] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1028; }","duration":"1.460032278s","start":"2026-06-08T18:52:31.252638Z","end":"2026-06-08T18:52:32.712671Z","steps":["trace[250479395] 'agreement among raft nodes before linearized reading' (duration: 1.459854304s)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:52:32.712704Z","caller":"traceutil/trace.go:171","msg":"trace[1482671639] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1028; }","duration":"1.459486787s","start":"2026-06-08T18:52:31.253203Z","end":"2026-06-08T18:52:32.71269Z","steps":["trace[1482671639] 'agreement among raft nodes before linearized reading' (duration: 1.459334614s)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:52:32.712708Z","caller":"traceutil/trace.go:171","msg":"trace[1173336643] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1028; }","duration":"428.730654ms","start":"2026-06-08T18:52:32.283969Z","end":"2026-06-08T18:52:32.7127Z","steps":["trace[1173336643] 'agreement among raft nodes before linearized reading' (duration: 428.688843ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:52:32.71274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:52:31.252626Z","time spent":"1.460102239s","remote":"127.0.0.1:42964","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-06-08T18:52:32.712747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:52:31.253183Z","time spent":"1.459553398s","remote":"127.0.0.1:42964","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-06-08T18:52:32.712747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:52:32.283954Z","time spent":"428.785996ms","remote":"127.0.0.1:42718","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-06-08T18:52:32.712872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.333257977s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T18:52:32.712922Z","caller":"traceutil/trace.go:171","msg":"trace[340664177] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1028; }","duration":"1.333343949s","start":"2026-06-08T18:52:31.379566Z","end":"2026-06-08T18:52:32.71291Z","steps":["trace[340664177] 'agreement among raft nodes before linearized reading' (duration: 1.333271538s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:52:32.712971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:52:31.379545Z","time spent":"1.33341334s","remote":"127.0.0.1:42994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"info","ts":"2026-06-08T18:52:32.712365Z","caller":"traceutil/trace.go:171","msg":"trace[1061329014] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"1.036378169s","start":"2026-06-08T18:52:31.675949Z","end":"2026-06-08T18:52:32.712327Z","steps":["trace[1061329014] 'process raft request' (duration: 463.711363ms)","trace[1061329014] 'compare' (duration: 571.896642ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:52:32.713077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.474195921s","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-06-08T18:52:32.713253Z","caller":"traceutil/trace.go:171","msg":"trace[211637379] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1028; }","duration":"1.474454916s","start":"2026-06-08T18:52:31.238767Z","end":"2026-06-08T18:52:32.713222Z","steps":["trace[211637379] 'agreement among raft nodes before linearized reading' (duration: 1.473644881s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:52:32.713345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:52:31.238734Z","time spent":"1.474597759s","remote":"127.0.0.1:42964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-08T18:52:32.712633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:52:31.60657Z","time spent":"1.106055916s","remote":"127.0.0.1:42724","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-06-08T18:52:32.712938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.460128568s","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-06-08T18:52:32.713588Z","caller":"traceutil/trace.go:171","msg":"trace[1759221925] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1028; }","duration":"1.460773291s","start":"2026-06-08T18:52:31.252762Z","end":"2026-06-08T18:52:32.713536Z","steps":["trace[1759221925] 'agreement among raft nodes before linearized reading' (duration: 1.460093458s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:52:32.713665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:52:31.252736Z","time spent":"1.460909834s","remote":"127.0.0.1:42964","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-06-08T18:52:32.713159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:52:31.675933Z","time spent":"1.037162725s","remote":"127.0.0.1:42964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T18:53:00.138571Z","caller":"traceutil/trace.go:171","msg":"trace[937736138] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"212.561687ms","start":"2026-06-08T18:52:59.925988Z","end":"2026-06-08T18:53:00.13855Z","steps":["trace[937736138] 'process raft request' (duration: 212.425315ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:53:01.043643Z","caller":"traceutil/trace.go:171","msg":"trace[1696789335] linearizableReadLoop","detail":"{readStateIndex:1163; appliedIndex:1162; }","duration":"120.756371ms","start":"2026-06-08T18:53:00.922864Z","end":"2026-06-08T18:53:01.043621Z","steps":["trace[1696789335] 'read index received' (duration: 120.576128ms)","trace[1696789335] 'applied index is now lower than readState.Index' (duration: 179.273µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:53:01.0437Z","caller":"traceutil/trace.go:171","msg":"trace[544822901] transaction","detail":"{read_only:false; response_revision:1121; number_of_response:1; }","duration":"250.527147ms","start":"2026-06-08T18:53:00.79315Z","end":"2026-06-08T18:53:01.043677Z","steps":["trace[544822901] 'process raft request' (duration: 250.304643ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:01.043866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.983675ms","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-06-08T18:53:01.043932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.936413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-08T18:53:01.043956Z","caller":"traceutil/trace.go:171","msg":"trace[2088865973] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1121; }","duration":"111.981343ms","start":"2026-06-08T18:53:00.931968Z","end":"2026-06-08T18:53:01.043949Z","steps":["trace[2088865973] 'agreement among raft nodes before linearized reading' (duration: 111.874431ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:53:01.043959Z","caller":"traceutil/trace.go:171","msg":"trace[319861746] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1121; }","duration":"121.128668ms","start":"2026-06-08T18:53:00.922819Z","end":"2026-06-08T18:53:01.043947Z","steps":["trace[319861746] 'agreement among raft nodes before linearized reading' (duration: 120.930645ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:01.044028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.276949ms","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-06-08T18:53:01.04405Z","caller":"traceutil/trace.go:171","msg":"trace[305887766] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1121; }","duration":"112.31333ms","start":"2026-06-08T18:53:00.931732Z","end":"2026-06-08T18:53:01.044046Z","steps":["trace[305887766] 'agreement among raft nodes before linearized reading' (duration: 112.264948ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:01.044014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.873519ms","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-06-08T18:53:01.044103Z","caller":"traceutil/trace.go:171","msg":"trace[642770184] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1121; }","duration":"115.001942ms","start":"2026-06-08T18:53:00.929075Z","end":"2026-06-08T18:53:01.044077Z","steps":["trace[642770184] 'agreement among raft nodes before linearized reading' (duration: 114.769646ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:01.786884Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8055706805335921059,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-08T18:53:01.869923Z","caller":"traceutil/trace.go:171","msg":"trace[408573530] linearizableReadLoop","detail":"{readStateIndex:1167; appliedIndex:1163; }","duration":"584.05358ms","start":"2026-06-08T18:53:01.285844Z","end":"2026-06-08T18:53:01.869898Z","steps":["trace[408573530] 'read index received' (duration: 528.913941ms)","trace[408573530] 'applied index is now lower than readState.Index' (duration: 55.138819ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:53:01.870042Z","caller":"traceutil/trace.go:171","msg":"trace[1242970764] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"821.552368ms","start":"2026-06-08T18:53:01.048476Z","end":"2026-06-08T18:53:01.870029Z","steps":["trace[1242970764] 'process raft request' (duration: 766.259125ms)","trace[1242970764] 'compare' (duration: 54.797154ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:53:01.870153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:01.048454Z","time spent":"821.624299ms","remote":"127.0.0.1:42964","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-06-08T18:53:01.870175Z","caller":"traceutil/trace.go:171","msg":"trace[1624856416] transaction","detail":"{read_only:false; response_revision:1125; number_of_response:1; }","duration":"820.165761ms","start":"2026-06-08T18:53:01.049936Z","end":"2026-06-08T18:53:01.870102Z","steps":["trace[1624856416] 'process raft request' (duration: 819.925837ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:01.870367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:01.04993Z","time spent":"820.337445ms","remote":"127.0.0.1:42964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T18:53:01.870543Z","caller":"traceutil/trace.go:171","msg":"trace[204263411] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"820.945918ms","start":"2026-06-08T18:53:01.049553Z","end":"2026-06-08T18:53:01.870499Z","steps":["trace[204263411] 'process raft request' (duration: 820.274984ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:01.870709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:01.049545Z","time spent":"821.07989ms","remote":"127.0.0.1:42964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T18:53:01.870736Z","caller":"traceutil/trace.go:171","msg":"trace[71881083] transaction","detail":"{read_only:false; response_revision:1123; number_of_response:1; }","duration":"821.093901ms","start":"2026-06-08T18:53:01.049407Z","end":"2026-06-08T18:53:01.870501Z","steps":["trace[71881083] 'process raft request' (duration: 820.373946ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:01.870919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.553773ms","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":"info","ts":"2026-06-08T18:53:01.871047Z","caller":"traceutil/trace.go:171","msg":"trace[590019947] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1125; }","duration":"399.772236ms","start":"2026-06-08T18:53:01.471251Z","end":"2026-06-08T18:53:01.871024Z","steps":["trace[590019947] 'agreement among raft nodes before linearized reading' (duration: 399.41813ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:01.871132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:01.471238Z","time spent":"399.878019ms","remote":"127.0.0.1:58018","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":"warn","ts":"2026-06-08T18:53:01.870447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.606052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T18:53:01.871509Z","caller":"traceutil/trace.go:171","msg":"trace[2013253304] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1125; }","duration":"585.682622ms","start":"2026-06-08T18:53:01.285796Z","end":"2026-06-08T18:53:01.871479Z","steps":["trace[2013253304] 'agreement among raft nodes before linearized reading' (duration: 584.614552ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:01.871605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:01.285777Z","time spent":"585.768815ms","remote":"127.0.0.1:42724","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-06-08T18:53:01.871481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:01.049387Z","time spent":"821.497378ms","remote":"127.0.0.1:42964","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-06-08T18:53:02.271175Z","caller":"traceutil/trace.go:171","msg":"trace[1880604571] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"124.101627ms","start":"2026-06-08T18:53:02.147045Z","end":"2026-06-08T18:53:02.271147Z","steps":["trace[1880604571] 'process raft request' (duration: 123.971014ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:53:03.243732Z","caller":"traceutil/trace.go:171","msg":"trace[563370821] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"194.756657ms","start":"2026-06-08T18:53:03.048952Z","end":"2026-06-08T18:53:03.243708Z","steps":["trace[563370821] 'process raft request' (duration: 194.602033ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:03.793893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.931376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T18:53:03.793989Z","caller":"traceutil/trace.go:171","msg":"trace[1615040140] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1127; }","duration":"508.095329ms","start":"2026-06-08T18:53:03.285874Z","end":"2026-06-08T18:53:03.793969Z","steps":["trace[1615040140] 'range keys from in-memory index tree' (duration: 507.823863ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:03.794035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:03.285855Z","time spent":"508.171001ms","remote":"127.0.0.1:42718","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-06-08T18:53:03.793908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.903555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.223\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-08T18:53:03.794297Z","caller":"traceutil/trace.go:171","msg":"trace[114105506] range","detail":"{range_begin:/registry/masterleases/199.19.213.223; range_end:; response_count:1; response_revision:1127; }","duration":"430.357885ms","start":"2026-06-08T18:53:03.363896Z","end":"2026-06-08T18:53:03.794254Z","steps":["trace[114105506] 'range keys from in-memory index tree' (duration: 429.686341ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:03.794416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:03.363873Z","time spent":"430.502988ms","remote":"127.0.0.1:42744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.223\" "} {"level":"info","ts":"2026-06-08T18:53:04.011839Z","caller":"traceutil/trace.go:171","msg":"trace[1136305746] transaction","detail":"{read_only:false; response_revision:1129; number_of_response:1; }","duration":"134.364273ms","start":"2026-06-08T18:53:03.877445Z","end":"2026-06-08T18:53:04.011809Z","steps":["trace[1136305746] 'process raft request' (duration: 104.955418ms)","trace[1136305746] 'compare' (duration: 29.13064ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:53:04.776352Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8055706805335921086,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-08T18:53:05.067492Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.085264279s","expected-duration":"1s"} {"level":"info","ts":"2026-06-08T18:53:05.067968Z","caller":"traceutil/trace.go:171","msg":"trace[33473292] linearizableReadLoop","detail":"{readStateIndex:1175; appliedIndex:1172; }","duration":"792.219364ms","start":"2026-06-08T18:53:04.275726Z","end":"2026-06-08T18:53:05.067946Z","steps":["trace[33473292] 'read index received' (duration: 791.947529ms)","trace[33473292] 'applied index is now lower than readState.Index' (duration: 270.855µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:53:05.068014Z","caller":"traceutil/trace.go:171","msg":"trace[392134974] transaction","detail":"{read_only:false; response_revision:1130; number_of_response:1; }","duration":"1.186283461s","start":"2026-06-08T18:53:03.881685Z","end":"2026-06-08T18:53:05.067968Z","steps":["trace[392134974] 'process raft request' (duration: 1.186046807s)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:53:05.068053Z","caller":"traceutil/trace.go:171","msg":"trace[1797224544] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"1.186135889s","start":"2026-06-08T18:53:03.881906Z","end":"2026-06-08T18:53:05.068042Z","steps":["trace[1797224544] 'process raft request' (duration: 1.186003255s)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:53:05.06804Z","caller":"traceutil/trace.go:171","msg":"trace[1907376398] transaction","detail":"{read_only:false; response_revision:1131; number_of_response:1; }","duration":"1.186324152s","start":"2026-06-08T18:53:03.881683Z","end":"2026-06-08T18:53:05.068007Z","steps":["trace[1907376398] 'process raft request' (duration: 1.186189469s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:05.068159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:03.881671Z","time spent":"1.186408584s","remote":"127.0.0.1:42964","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-06-08T18:53:05.068165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:03.881863Z","time spent":"1.18622359s","remote":"127.0.0.1:42964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T18:53:05.068204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:03.881654Z","time spent":"1.186457495s","remote":"127.0.0.1:42964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T18:53:05.068329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"782.0934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-08T18:53:05.068386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"792.669103ms","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-06-08T18:53:05.06841Z","caller":"traceutil/trace.go:171","msg":"trace[523911478] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1132; }","duration":"782.177221ms","start":"2026-06-08T18:53:04.286218Z","end":"2026-06-08T18:53:05.068396Z","steps":["trace[523911478] 'agreement among raft nodes before linearized reading' (duration: 782.030118ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:53:05.068418Z","caller":"traceutil/trace.go:171","msg":"trace[1642049558] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1132; }","duration":"792.736964ms","start":"2026-06-08T18:53:04.275672Z","end":"2026-06-08T18:53:05.068409Z","steps":["trace[1642049558] 'agreement among raft nodes before linearized reading' (duration: 792.610452ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:05.068448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:04.275647Z","time spent":"792.794885ms","remote":"127.0.0.1:42964","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-06-08T18:53:05.068451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:04.28616Z","time spent":"782.282494ms","remote":"127.0.0.1:42724","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-06-08T18:53:05.243724Z","caller":"traceutil/trace.go:171","msg":"trace[198412474] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"171.179052ms","start":"2026-06-08T18:53:05.072516Z","end":"2026-06-08T18:53:05.243695Z","steps":["trace[198412474] 'process raft request' (duration: 109.965304ms)","trace[198412474] 'compare' (duration: 60.958743ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:53:17.054995Z","caller":"traceutil/trace.go:171","msg":"trace[888679470] transaction","detail":"{read_only:false; response_revision:1184; number_of_response:1; }","duration":"120.66225ms","start":"2026-06-08T18:53:16.934306Z","end":"2026-06-08T18:53:17.054968Z","steps":["trace[888679470] 'process raft request' (duration: 120.471856ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:53:20.605019Z","caller":"traceutil/trace.go:171","msg":"trace[1689978083] linearizableReadLoop","detail":"{readStateIndex:1281; appliedIndex:1280; }","duration":"315.591748ms","start":"2026-06-08T18:53:20.289406Z","end":"2026-06-08T18:53:20.604997Z","steps":["trace[1689978083] 'read index received' (duration: 315.387955ms)","trace[1689978083] 'applied index is now lower than readState.Index' (duration: 202.913µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:53:20.605119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.69192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T18:53:20.605143Z","caller":"traceutil/trace.go:171","msg":"trace[1452479526] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1233; }","duration":"315.764221ms","start":"2026-06-08T18:53:20.289371Z","end":"2026-06-08T18:53:20.605135Z","steps":["trace[1452479526] 'agreement among raft nodes before linearized reading' (duration: 315.70487ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:20.605167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:20.289355Z","time spent":"315.807072ms","remote":"127.0.0.1:42724","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-06-08T18:53:20.605122Z","caller":"traceutil/trace.go:171","msg":"trace[126303870] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"507.967277ms","start":"2026-06-08T18:53:20.097111Z","end":"2026-06-08T18:53:20.605078Z","steps":["trace[126303870] 'process raft request' (duration: 507.754983ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:20.605345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:20.097096Z","time spent":"508.15587ms","remote":"127.0.0.1:42964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T18:53:37.324232Z","caller":"traceutil/trace.go:171","msg":"trace[1708955369] linearizableReadLoop","detail":"{readStateIndex:1357; appliedIndex:1356; }","duration":"141.808887ms","start":"2026-06-08T18:53:37.182389Z","end":"2026-06-08T18:53:37.324198Z","steps":["trace[1708955369] 'read index received' (duration: 141.663224ms)","trace[1708955369] 'applied index is now lower than readState.Index' (duration: 144.353µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:53:37.324317Z","caller":"traceutil/trace.go:171","msg":"trace[1613630850] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"651.031489ms","start":"2026-06-08T18:53:36.673235Z","end":"2026-06-08T18:53:37.324266Z","steps":["trace[1613630850] 'process raft request' (duration: 650.762044ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:37.324476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.021901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-08T18:53:37.32456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:36.673215Z","time spent":"651.224083ms","remote":"127.0.0.1:42964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T18:53:37.324598Z","caller":"traceutil/trace.go:171","msg":"trace[1555120272] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1306; }","duration":"142.235586ms","start":"2026-06-08T18:53:37.182341Z","end":"2026-06-08T18:53:37.324576Z","steps":["trace[1555120272] 'agreement among raft nodes before linearized reading' (duration: 141.996581ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:37.904709Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8055706805335921473,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-08T18:53:38.405591Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8055706805335921473,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-08T18:53:38.769182Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.438890408s","expected-duration":"1s"} {"level":"info","ts":"2026-06-08T18:53:38.769739Z","caller":"traceutil/trace.go:171","msg":"trace[916478117] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"1.439600332s","start":"2026-06-08T18:53:37.330108Z","end":"2026-06-08T18:53:38.769708Z","steps":["trace[916478117] 'process raft request' (duration: 1.439434589s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:38.769902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:37.330079Z","time spent":"1.439741085s","remote":"127.0.0.1:42964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T18:53:38.881505Z","caller":"traceutil/trace.go:171","msg":"trace[464017414] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"1.55130452s","start":"2026-06-08T18:53:37.330173Z","end":"2026-06-08T18:53:38.881478Z","steps":["trace[464017414] 'process raft request' (duration: 1.479713244s)","trace[464017414] 'compare' (duration: 71.394963ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:53:38.881666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:37.330145Z","time spent":"1.551436382s","remote":"127.0.0.1:42964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T18:53:38.881769Z","caller":"traceutil/trace.go:171","msg":"trace[1100624120] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"1.551575805s","start":"2026-06-08T18:53:37.330173Z","end":"2026-06-08T18:53:38.881749Z","steps":["trace[1100624120] 'process raft request' (duration: 1.551244859s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:38.881873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:37.330146Z","time spent":"1.551674667s","remote":"127.0.0.1:42964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T18:53:38.882063Z","caller":"traceutil/trace.go:171","msg":"trace[725310283] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"1.469245292s","start":"2026-06-08T18:53:37.4128Z","end":"2026-06-08T18:53:38.882045Z","steps":["trace[725310283] 'process raft request' (duration: 1.468871255s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:38.882166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:37.412785Z","time spent":"1.469324173s","remote":"127.0.0.1:42964","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-06-08T18:53:39.076409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.444719ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-08T18:53:39.076608Z","caller":"traceutil/trace.go:171","msg":"trace[531248943] linearizableReadLoop","detail":"{readStateIndex:1361; appliedIndex:1357; }","duration":"1.672879338s","start":"2026-06-08T18:53:37.403715Z","end":"2026-06-08T18:53:39.076594Z","steps":["trace[531248943] 'read index received' (duration: 1.365786883s)","trace[531248943] 'applied index is now lower than readState.Index' (duration: 307.091755ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:53:39.076747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.673044001s","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-06-08T18:53:39.076766Z","caller":"traceutil/trace.go:171","msg":"trace[2056511007] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1310; }","duration":"1.673122263s","start":"2026-06-08T18:53:37.403637Z","end":"2026-06-08T18:53:39.07676Z","steps":["trace[2056511007] 'agreement among raft nodes before linearized reading' (duration: 1.673038151s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:39.076784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:37.40361Z","time spent":"1.673169323s","remote":"127.0.0.1:42964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-08T18:53:39.077534Z","caller":"traceutil/trace.go:171","msg":"trace[1884043727] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"132.553219ms","start":"2026-06-08T18:53:38.944967Z","end":"2026-06-08T18:53:39.07752Z","steps":["trace[1884043727] 'process raft request' (duration: 131.530609ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:39.190887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"723.784708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T18:53:39.190972Z","caller":"traceutil/trace.go:171","msg":"trace[157738640] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1311; }","duration":"723.93426ms","start":"2026-06-08T18:53:38.467018Z","end":"2026-06-08T18:53:39.190952Z","steps":["trace[157738640] 'agreement among raft nodes before linearized reading' (duration: 610.498769ms)","trace[157738640] 'count revisions from in-memory index tree' (duration: 113.300229ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:53:39.191011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:38.466997Z","time spent":"724.005682ms","remote":"127.0.0.1:57836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-08T18:53:39.190971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.72708928s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T18:53:39.191086Z","caller":"traceutil/trace.go:171","msg":"trace[1198922367] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1311; }","duration":"1.727275324s","start":"2026-06-08T18:53:37.463779Z","end":"2026-06-08T18:53:39.191054Z","steps":["trace[1198922367] 'agreement among raft nodes before linearized reading' (duration: 1.613721591s)","trace[1198922367] 'count revisions from in-memory index tree' (duration: 113.37029ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:53:39.191145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:37.463761Z","time spent":"1.727373065s","remote":"127.0.0.1:43160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"info","ts":"2026-06-08T18:53:39.191946Z","caller":"traceutil/trace.go:171","msg":"trace[1165729022] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"110.008175ms","start":"2026-06-08T18:53:39.081897Z","end":"2026-06-08T18:53:39.191905Z","steps":["trace[1165729022] 'process raft request' (duration: 86.413962ms)","trace[1165729022] 'compare' (duration: 22.494822ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:53:40.266602Z","caller":"traceutil/trace.go:171","msg":"trace[1063351188] linearizableReadLoop","detail":"{readStateIndex:1367; appliedIndex:1366; }","duration":"271.853867ms","start":"2026-06-08T18:53:39.994726Z","end":"2026-06-08T18:53:40.26658Z","steps":["trace[1063351188] 'read index received' (duration: 271.674694ms)","trace[1063351188] 'applied index is now lower than readState.Index' (duration: 178.333µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:53:40.266927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.171594ms","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-06-08T18:53:40.266959Z","caller":"traceutil/trace.go:171","msg":"trace[1720844175] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1315; }","duration":"272.285756ms","start":"2026-06-08T18:53:39.994666Z","end":"2026-06-08T18:53:40.266951Z","steps":["trace[1720844175] 'agreement among raft nodes before linearized reading' (duration: 272.183044ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:53:40.267194Z","caller":"traceutil/trace.go:171","msg":"trace[533979933] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"363.120572ms","start":"2026-06-08T18:53:39.904066Z","end":"2026-06-08T18:53:40.267187Z","steps":["trace[533979933] 'process raft request' (duration: 362.388529ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:40.267254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:39.904033Z","time spent":"363.184144ms","remote":"127.0.0.1:42786","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-06-08T18:53:40.992023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.394489ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-08T18:53:40.99213Z","caller":"traceutil/trace.go:171","msg":"trace[1970137181] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"720.943903ms","start":"2026-06-08T18:53:40.271165Z","end":"2026-06-08T18:53:40.992109Z","steps":["trace[1970137181] 'process raft request' (duration: 255.398191ms)","trace[1970137181] 'compare' (duration: 465.266057ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:53:40.992179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:40.271149Z","time spent":"721.010284ms","remote":"127.0.0.1:42964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-08T18:53:41.289282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.624014ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-08T18:53:41.28954Z","caller":"traceutil/trace.go:171","msg":"trace[1010078307] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"290.820502ms","start":"2026-06-08T18:53:40.998701Z","end":"2026-06-08T18:53:41.289521Z","steps":["trace[1010078307] 'process raft request' (duration: 290.782422ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:53:41.289768Z","caller":"traceutil/trace.go:171","msg":"trace[518910422] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"920.317708ms","start":"2026-06-08T18:53:40.369438Z","end":"2026-06-08T18:53:41.289756Z","steps":["trace[518910422] 'process raft request' (duration: 806.145842ms)","trace[518910422] 'compare' (duration: 113.350889ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:53:41.289825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:40.369402Z","time spent":"920.397068ms","remote":"127.0.0.1:42786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-08T18:53:41.289882Z","caller":"traceutil/trace.go:171","msg":"trace[489644049] linearizableReadLoop","detail":"{readStateIndex:1369; appliedIndex:1367; }","duration":"798.799141ms","start":"2026-06-08T18:53:40.491062Z","end":"2026-06-08T18:53:41.289861Z","steps":["trace[489644049] 'read index received' (duration: 35.484733ms)","trace[489644049] 'applied index is now lower than readState.Index' (duration: 763.312617ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:53:41.289985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.923512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T18:53:41.290031Z","caller":"traceutil/trace.go:171","msg":"trace[1374463382] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1319; }","duration":"799.021944ms","start":"2026-06-08T18:53:40.490996Z","end":"2026-06-08T18:53:41.290018Z","steps":["trace[1374463382] 'agreement among raft nodes before linearized reading' (duration: 798.950713ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:41.290061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:40.490968Z","time spent":"799.086566ms","remote":"127.0.0.1:57966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-06-08T18:53:41.290096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.740487ms","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-06-08T18:53:41.290138Z","caller":"traceutil/trace.go:171","msg":"trace[1115400249] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1319; }","duration":"515.827108ms","start":"2026-06-08T18:53:40.774301Z","end":"2026-06-08T18:53:41.290128Z","steps":["trace[1115400249] 'agreement among raft nodes before linearized reading' (duration: 515.694106ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:53:41.289986Z","caller":"traceutil/trace.go:171","msg":"trace[64020293] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"400.126885ms","start":"2026-06-08T18:53:40.88979Z","end":"2026-06-08T18:53:41.289917Z","steps":["trace[64020293] 'process raft request' (duration: 399.602404ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:41.290252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.316308ms","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-06-08T18:53:41.290287Z","caller":"traceutil/trace.go:171","msg":"trace[1207153011] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1319; }","duration":"400.407489ms","start":"2026-06-08T18:53:40.889871Z","end":"2026-06-08T18:53:41.290279Z","steps":["trace[1207153011] 'agreement among raft nodes before linearized reading' (duration: 400.323068ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:41.290297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.855323ms","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-06-08T18:53:41.290322Z","caller":"traceutil/trace.go:171","msg":"trace[1549436099] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1319; }","duration":"290.937515ms","start":"2026-06-08T18:53:40.999378Z","end":"2026-06-08T18:53:41.290316Z","steps":["trace[1549436099] 'agreement among raft nodes before linearized reading' (duration: 290.870494ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:41.290323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:40.889839Z","time spent":"400.475791ms","remote":"127.0.0.1:42964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-08T18:53:41.290426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:40.889754Z","time spent":"400.47022ms","remote":"127.0.0.1:42964","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-06-08T18:53:41.290176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:40.774278Z","time spent":"515.890919ms","remote":"127.0.0.1:42964","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-06-08T18:53:41.290415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.348018ms","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-06-08T18:53:41.290671Z","caller":"traceutil/trace.go:171","msg":"trace[662447050] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1319; }","duration":"400.610333ms","start":"2026-06-08T18:53:40.889981Z","end":"2026-06-08T18:53:41.290591Z","steps":["trace[662447050] 'agreement among raft nodes before linearized reading' (duration: 400.159115ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:41.29075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:40.889945Z","time spent":"400.794637ms","remote":"127.0.0.1:42964","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-06-08T18:53:41.876922Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8055706805335921498,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-08T18:53:42.372237Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.043438334s","expected-duration":"1s"} {"level":"info","ts":"2026-06-08T18:53:42.372687Z","caller":"traceutil/trace.go:171","msg":"trace[1192657655] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"1.074906789s","start":"2026-06-08T18:53:41.297743Z","end":"2026-06-08T18:53:42.37265Z","steps":["trace[1192657655] 'process raft request' (duration: 1.074868508s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:42.372837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:41.297739Z","time spent":"1.075022321s","remote":"127.0.0.1:42964","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-06-08T18:53:42.373126Z","caller":"traceutil/trace.go:171","msg":"trace[1989748342] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"1.078276334s","start":"2026-06-08T18:53:41.294837Z","end":"2026-06-08T18:53:42.373113Z","steps":["trace[1989748342] 'process raft request' (duration: 1.077708133s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:42.373193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:41.29482Z","time spent":"1.078339345s","remote":"127.0.0.1:42964","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-06-08T18:53:42.373327Z","caller":"traceutil/trace.go:171","msg":"trace[1475703711] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"1.078211243s","start":"2026-06-08T18:53:41.295085Z","end":"2026-06-08T18:53:42.373296Z","steps":["trace[1475703711] 'process raft request' (duration: 1.077494849s)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:53:42.373112Z","caller":"traceutil/trace.go:171","msg":"trace[2046441583] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"1.078253564s","start":"2026-06-08T18:53:41.294806Z","end":"2026-06-08T18:53:42.37306Z","steps":["trace[2046441583] 'process raft request' (duration: 1.077601772s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:42.373491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:41.295079Z","time spent":"1.078329145s","remote":"127.0.0.1:42964","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-06-08T18:53:42.374156Z","caller":"traceutil/trace.go:171","msg":"trace[407773912] linearizableReadLoop","detail":"{readStateIndex:1377; appliedIndex:1377; }","duration":"997.643353ms","start":"2026-06-08T18:53:41.376496Z","end":"2026-06-08T18:53:42.374139Z","steps":["trace[407773912] 'read index received' (duration: 997.636693ms)","trace[407773912] 'applied index is now lower than readState.Index' (duration: 4.98µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:53:42.374495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"997.98881ms","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-06-08T18:53:42.374614Z","caller":"traceutil/trace.go:171","msg":"trace[1372336397] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1325; }","duration":"998.161853ms","start":"2026-06-08T18:53:41.376437Z","end":"2026-06-08T18:53:42.374599Z","steps":["trace[1372336397] 'agreement among raft nodes before linearized reading' (duration: 997.806806ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:42.374618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:41.294801Z","time spent":"1.078812345s","remote":"127.0.0.1:42964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T18:53:42.374747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:41.376409Z","time spent":"998.323887ms","remote":"127.0.0.1:42964","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-06-08T18:53:44.093215Z","caller":"traceutil/trace.go:171","msg":"trace[242190542] linearizableReadLoop","detail":"{readStateIndex:1388; appliedIndex:1387; }","duration":"101.855938ms","start":"2026-06-08T18:53:43.99133Z","end":"2026-06-08T18:53:44.093186Z","steps":["trace[242190542] 'read index received' (duration: 53.862706ms)","trace[242190542] 'applied index is now lower than readState.Index' (duration: 47.992262ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:53:44.093285Z","caller":"traceutil/trace.go:171","msg":"trace[634047499] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"102.429339ms","start":"2026-06-08T18:53:43.990805Z","end":"2026-06-08T18:53:44.093234Z","steps":["trace[634047499] 'process raft request' (duration: 54.399906ms)","trace[634047499] 'compare' (duration: 47.83186ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:53:44.093481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.129934ms","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-06-08T18:53:44.093556Z","caller":"traceutil/trace.go:171","msg":"trace[976328357] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1335; }","duration":"102.223686ms","start":"2026-06-08T18:53:43.991312Z","end":"2026-06-08T18:53:44.093536Z","steps":["trace[976328357] 'agreement among raft nodes before linearized reading' (duration: 101.966001ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:53:49.57293Z","caller":"traceutil/trace.go:171","msg":"trace[184387789] transaction","detail":"{read_only:false; response_revision:1381; number_of_response:1; }","duration":"450.37288ms","start":"2026-06-08T18:53:49.12253Z","end":"2026-06-08T18:53:49.572903Z","steps":["trace[184387789] 'process raft request' (duration: 450.197557ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:49.573097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:49.122513Z","time spent":"450.503823ms","remote":"127.0.0.1:42964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T18:53:50.482399Z","caller":"traceutil/trace.go:171","msg":"trace[897958636] linearizableReadLoop","detail":"{readStateIndex:1436; appliedIndex:1434; }","duration":"1.195697481s","start":"2026-06-08T18:53:49.286676Z","end":"2026-06-08T18:53:50.482373Z","steps":["trace[897958636] 'read index received' (duration: 286.144402ms)","trace[897958636] 'applied index is now lower than readState.Index' (duration: 909.551749ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:53:50.482527Z","caller":"traceutil/trace.go:171","msg":"trace[25288951] transaction","detail":"{read_only:false; response_revision:1383; number_of_response:1; }","duration":"1.169814274s","start":"2026-06-08T18:53:49.312698Z","end":"2026-06-08T18:53:50.482512Z","steps":["trace[25288951] 'process raft request' (duration: 1.169471858s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:50.482622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:49.312672Z","time spent":"1.169879865s","remote":"127.0.0.1:42964","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-06-08T18:53:50.482749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.196073479s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T18:53:50.48278Z","caller":"traceutil/trace.go:171","msg":"trace[2022947764] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1383; }","duration":"1.196144211s","start":"2026-06-08T18:53:49.286626Z","end":"2026-06-08T18:53:50.48277Z","steps":["trace[2022947764] 'agreement among raft nodes before linearized reading' (duration: 1.196093049s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:50.482806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:49.286604Z","time spent":"1.196196142s","remote":"127.0.0.1:42724","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-06-08T18:53:50.483072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.120093008s","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-06-08T18:53:50.483156Z","caller":"traceutil/trace.go:171","msg":"trace[1781204226] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1383; }","duration":"1.120371533s","start":"2026-06-08T18:53:49.362764Z","end":"2026-06-08T18:53:50.483135Z","steps":["trace[1781204226] 'agreement among raft nodes before linearized reading' (duration: 1.120036377s)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:53:50.482253Z","caller":"traceutil/trace.go:171","msg":"trace[302014015] transaction","detail":"{read_only:false; response_revision:1382; number_of_response:1; }","duration":"1.278402342s","start":"2026-06-08T18:53:49.203821Z","end":"2026-06-08T18:53:50.482223Z","steps":["trace[302014015] 'process raft request' (duration: 1.278173447s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:50.483203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:49.362732Z","time spent":"1.120453684s","remote":"127.0.0.1:42964","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-06-08T18:53:50.483319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:49.203796Z","time spent":"1.279422692s","remote":"127.0.0.1:42964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T18:53:50.483599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"680.598907ms","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-06-08T18:53:50.483696Z","caller":"traceutil/trace.go:171","msg":"trace[885131399] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1383; }","duration":"680.727809ms","start":"2026-06-08T18:53:49.802943Z","end":"2026-06-08T18:53:50.483671Z","steps":["trace[885131399] 'agreement among raft nodes before linearized reading' (duration: 680.432134ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:53:50.483786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:53:49.802843Z","time spent":"680.925113ms","remote":"127.0.0.1:42964","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\" "}