{"level":"warn","ts":"2026-05-30T05:16:38.036837Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-30T05:16:38.036946Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.138:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.138:2380","--initial-cluster=instance=https://199.204.45.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.138: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-05-30T05:16:38.037037Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-30T05:16:38.037053Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-05-30T05:16:38.037079Z","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-05-30T05:16:38.037842Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"]} {"level":"info","ts":"2026-05-30T05:16:38.037926Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.138: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-05-30T05:16:38.043461Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.324983ms"} {"level":"info","ts":"2026-05-30T05:16:38.051272Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f3d52791b64f7591","cluster-id":"90076b89649fe294"} {"level":"info","ts":"2026-05-30T05:16:38.051369Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=()"} {"level":"info","ts":"2026-05-30T05:16:38.051401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 0"} {"level":"info","ts":"2026-05-30T05:16:38.051417Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f3d52791b64f7591 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-30T05:16:38.05143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 1"} {"level":"info","ts":"2026-05-30T05:16:38.051479Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"warn","ts":"2026-05-30T05:16:38.060992Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-30T05:16:38.062794Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-30T05:16:38.064213Z","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-05-30T05:16:38.066856Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f3d52791b64f7591","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-30T05:16:38.067037Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f3d52791b64f7591","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-30T05:16:38.067599Z","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-05-30T05:16:38.067764Z","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-05-30T05:16:38.067796Z","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-05-30T05:16:38.068439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"info","ts":"2026-05-30T05:16:38.068717Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","added-peer-id":"f3d52791b64f7591","added-peer-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-05-30T05:16:38.07121Z","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-05-30T05:16:38.071368Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-05-30T05:16:38.071441Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-05-30T05:16:38.0715Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f3d52791b64f7591","initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-30T05:16:38.071545Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-30T05:16:38.552577Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 is starting a new election at term 1"} {"level":"info","ts":"2026-05-30T05:16:38.552649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-30T05:16:38.552703Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgPreVoteResp from f3d52791b64f7591 at term 1"} {"level":"info","ts":"2026-05-30T05:16:38.552726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became candidate at term 2"} {"level":"info","ts":"2026-05-30T05:16:38.552738Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgVoteResp from f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-05-30T05:16:38.552756Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became leader at term 2"} {"level":"info","ts":"2026-05-30T05:16:38.552778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f3d52791b64f7591 elected leader f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-05-30T05:16:38.553998Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f3d52791b64f7591","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.138:2379]}","request-path":"/0/members/f3d52791b64f7591/attributes","cluster-id":"90076b89649fe294","publish-timeout":"7s"} {"level":"info","ts":"2026-05-30T05:16:38.554214Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-30T05:16:38.554261Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-30T05:16:38.554263Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T05:16:38.554936Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-30T05:16:38.555044Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-30T05:16:38.555085Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T05:16:38.555183Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T05:16:38.555208Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T05:16:38.575986Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.138:2379"} {"level":"info","ts":"2026-05-30T05:16:38.58338Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-30T05:17:16.072693Z","caller":"traceutil/trace.go:171","msg":"trace[1706705343] linearizableReadLoop","detail":"{readStateIndex:511; appliedIndex:510; }","duration":"173.631482ms","start":"2026-05-30T05:17:15.899031Z","end":"2026-05-30T05:17:16.072663Z","steps":["trace[1706705343] 'read index received' (duration: 172.940177ms)","trace[1706705343] 'applied index is now lower than readState.Index' (duration: 689.905µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:17:16.072793Z","caller":"traceutil/trace.go:171","msg":"trace[783273228] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"364.048968ms","start":"2026-05-30T05:17:15.708688Z","end":"2026-05-30T05:17:16.072737Z","steps":["trace[783273228] 'process raft request' (duration: 363.576147ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:16.072907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.856977ms","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-05-30T05:17:16.072977Z","caller":"traceutil/trace.go:171","msg":"trace[1280832211] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:496; }","duration":"173.999411ms","start":"2026-05-30T05:17:15.898965Z","end":"2026-05-30T05:17:16.072964Z","steps":["trace[1280832211] 'agreement among raft nodes before linearized reading' (duration: 173.832827ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:16.073574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:15.708649Z","time spent":"364.255793ms","remote":"127.0.0.1:39856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317292,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T05:17:19.031753Z","caller":"traceutil/trace.go:171","msg":"trace[642960461] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:605; }","duration":"494.908752ms","start":"2026-05-30T05:17:18.536823Z","end":"2026-05-30T05:17:19.031732Z","steps":["trace[642960461] 'read index received' (duration: 492.031756ms)","trace[642960461] 'applied index is now lower than readState.Index' (duration: 2.875516ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:17:19.032012Z","caller":"traceutil/trace.go:171","msg":"trace[662336886] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"497.052182ms","start":"2026-05-30T05:17:18.534937Z","end":"2026-05-30T05:17:19.031989Z","steps":["trace[662336886] 'process raft request' (duration: 493.90365ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.0322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:18.534903Z","time spent":"497.209996ms","remote":"127.0.0.1:39814","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T05:17:19.032213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.359833ms","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-05-30T05:17:19.032493Z","caller":"traceutil/trace.go:171","msg":"trace[2007876563] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:587; }","duration":"495.68691ms","start":"2026-05-30T05:17:18.536784Z","end":"2026-05-30T05:17:19.032471Z","steps":["trace[2007876563] 'agreement among raft nodes before linearized reading' (duration: 495.2558ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.032608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:18.53676Z","time spent":"495.822303ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-30T05:17:19.033291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.013337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T05:17:19.033194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.379208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:17:19.033329Z","caller":"traceutil/trace.go:171","msg":"trace[205141900] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:588; }","duration":"221.101699ms","start":"2026-05-30T05:17:18.812218Z","end":"2026-05-30T05:17:19.03332Z","steps":["trace[205141900] 'agreement among raft nodes before linearized reading' (duration: 221.040977ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.033407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.950513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:17:19.033355Z","caller":"traceutil/trace.go:171","msg":"trace[554182644] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:588; }","duration":"441.581512ms","start":"2026-05-30T05:17:18.591753Z","end":"2026-05-30T05:17:19.033334Z","steps":["trace[554182644] 'agreement among raft nodes before linearized reading' (duration: 441.361987ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:17:19.033482Z","caller":"traceutil/trace.go:171","msg":"trace[1736347135] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:588; }","duration":"328.030875ms","start":"2026-05-30T05:17:18.705431Z","end":"2026-05-30T05:17:19.033461Z","steps":["trace[1736347135] 'agreement among raft nodes before linearized reading' (duration: 327.904732ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.033532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:18.705407Z","time spent":"328.108486ms","remote":"127.0.0.1:38544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"warn","ts":"2026-05-30T05:17:19.033611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.295391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:17:19.033636Z","caller":"traceutil/trace.go:171","msg":"trace[790031630] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:588; }","duration":"127.355253ms","start":"2026-05-30T05:17:18.906274Z","end":"2026-05-30T05:17:19.03363Z","steps":["trace[790031630] 'agreement among raft nodes before linearized reading' (duration: 127.315452ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.033499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:18.591727Z","time spent":"441.753426ms","remote":"127.0.0.1:38528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-30T05:17:19.033737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.478086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:17:19.033759Z","caller":"traceutil/trace.go:171","msg":"trace[1144123766] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:588; }","duration":"127.539437ms","start":"2026-05-30T05:17:18.906214Z","end":"2026-05-30T05:17:19.033753Z","steps":["trace[1144123766] 'agreement among raft nodes before linearized reading' (duration: 127.502476ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.033797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.0038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T05:17:19.033837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.077963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:17:19.033854Z","caller":"traceutil/trace.go:171","msg":"trace[512087496] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:588; }","duration":"164.109614ms","start":"2026-05-30T05:17:18.869739Z","end":"2026-05-30T05:17:19.033848Z","steps":["trace[512087496] 'agreement among raft nodes before linearized reading' (duration: 164.081423ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:17:19.033859Z","caller":"traceutil/trace.go:171","msg":"trace[1606254384] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:588; }","duration":"254.119213ms","start":"2026-05-30T05:17:18.779724Z","end":"2026-05-30T05:17:19.033843Z","steps":["trace[1606254384] 'agreement among raft nodes before linearized reading' (duration: 254.026921ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.033951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.79914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:17:19.033975Z","caller":"traceutil/trace.go:171","msg":"trace[1101888482] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:588; }","duration":"164.853881ms","start":"2026-05-30T05:17:18.869115Z","end":"2026-05-30T05:17:19.033969Z","steps":["trace[1101888482] 'agreement among raft nodes before linearized reading' (duration: 164.817381ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.034054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.998585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:17:19.034075Z","caller":"traceutil/trace.go:171","msg":"trace[2105138003] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:588; }","duration":"165.057777ms","start":"2026-05-30T05:17:18.869011Z","end":"2026-05-30T05:17:19.034069Z","steps":["trace[2105138003] 'agreement among raft nodes before linearized reading' (duration: 165.026106ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.034105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.86793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:17:19.03416Z","caller":"traceutil/trace.go:171","msg":"trace[605247853] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:588; }","duration":"306.956121ms","start":"2026-05-30T05:17:18.72719Z","end":"2026-05-30T05:17:19.034146Z","steps":["trace[605247853] 'agreement among raft nodes before linearized reading' (duration: 306.87271ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.034172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.714222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T05:17:19.034161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.380085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:17:19.034194Z","caller":"traceutil/trace.go:171","msg":"trace[939264106] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:588; }","duration":"221.804984ms","start":"2026-05-30T05:17:18.812383Z","end":"2026-05-30T05:17:19.034188Z","steps":["trace[939264106] 'agreement among raft nodes before linearized reading' (duration: 221.756533ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:17:19.03421Z","caller":"traceutil/trace.go:171","msg":"trace[1874204229] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:588; }","duration":"329.432967ms","start":"2026-05-30T05:17:18.704762Z","end":"2026-05-30T05:17:19.034195Z","steps":["trace[1874204229] 'agreement among raft nodes before linearized reading' (duration: 329.345285ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.03426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:18.704672Z","time spent":"329.576ms","remote":"127.0.0.1:38554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-05-30T05:17:19.034297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.905347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:17:19.034317Z","caller":"traceutil/trace.go:171","msg":"trace[196119517] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:588; }","duration":"221.942937ms","start":"2026-05-30T05:17:18.812367Z","end":"2026-05-30T05:17:19.034309Z","steps":["trace[196119517] 'agreement among raft nodes before linearized reading' (duration: 221.891246ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.034395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.202888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T05:17:19.034455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.693497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:17:19.03446Z","caller":"traceutil/trace.go:171","msg":"trace[601799809] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:588; }","duration":"307.306111ms","start":"2026-05-30T05:17:18.727137Z","end":"2026-05-30T05:17:19.034443Z","steps":["trace[601799809] 'agreement among raft nodes before linearized reading' (duration: 307.102506ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.03456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.864937ms","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-05-30T05:17:19.034597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:18.727113Z","time spent":"307.385712ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"info","ts":"2026-05-30T05:17:19.034612Z","caller":"traceutil/trace.go:171","msg":"trace[1105906368] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:588; }","duration":"329.952009ms","start":"2026-05-30T05:17:18.704647Z","end":"2026-05-30T05:17:19.034599Z","steps":["trace[1105906368] 'agreement among raft nodes before linearized reading' (duration: 329.873417ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.034651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:18.704624Z","time spent":"330.017011ms","remote":"127.0.0.1:38554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-05-30T05:17:19.034577Z","caller":"traceutil/trace.go:171","msg":"trace[792148083] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"451.749176ms","start":"2026-05-30T05:17:18.582808Z","end":"2026-05-30T05:17:19.034557Z","steps":["trace[792148083] 'process raft request' (duration: 450.166569ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.03483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.447172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:17:19.034873Z","caller":"traceutil/trace.go:171","msg":"trace[1987438174] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:588; }","duration":"369.544045ms","start":"2026-05-30T05:17:18.665317Z","end":"2026-05-30T05:17:19.034861Z","steps":["trace[1987438174] 'agreement among raft nodes before linearized reading' (duration: 369.466623ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.034912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:18.665312Z","time spent":"369.589595ms","remote":"127.0.0.1:38544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-05-30T05:17:19.035139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.01841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:17:19.035172Z","caller":"traceutil/trace.go:171","msg":"trace[2038913518] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:588; }","duration":"288.09174ms","start":"2026-05-30T05:17:18.747071Z","end":"2026-05-30T05:17:19.035163Z","steps":["trace[2038913518] 'agreement among raft nodes before linearized reading' (duration: 288.042849ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.035157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.640264ms","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-05-30T05:17:19.035303Z","caller":"traceutil/trace.go:171","msg":"trace[1501823979] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:588; }","duration":"316.731636ms","start":"2026-05-30T05:17:18.718464Z","end":"2026-05-30T05:17:19.035196Z","steps":["trace[1501823979] 'agreement among raft nodes before linearized reading' (duration: 316.629044ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.035361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:18.718442Z","time spent":"316.905971ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-30T05:17:19.035368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.977551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:17:19.035228Z","caller":"traceutil/trace.go:171","msg":"trace[1171702646] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:588; }","duration":"254.793889ms","start":"2026-05-30T05:17:18.779688Z","end":"2026-05-30T05:17:19.034482Z","steps":["trace[1171702646] 'agreement among raft nodes before linearized reading' (duration: 254.742188ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.034399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.530817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:17:19.035452Z","caller":"traceutil/trace.go:171","msg":"trace[719113267] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:588; }","duration":"428.048813ms","start":"2026-05-30T05:17:18.607354Z","end":"2026-05-30T05:17:19.035403Z","steps":["trace[719113267] 'agreement among raft nodes before linearized reading' (duration: 427.838018ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:17:19.035629Z","caller":"traceutil/trace.go:171","msg":"trace[1376251734] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:588; }","duration":"305.791056ms","start":"2026-05-30T05:17:18.729824Z","end":"2026-05-30T05:17:19.035615Z","steps":["trace[1376251734] 'agreement among raft nodes before linearized reading' (duration: 304.234959ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.035668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:18.729811Z","time spent":"305.844636ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-05-30T05:17:19.035738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:18.60734Z","time spent":"428.35581ms","remote":"127.0.0.1:38540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-05-30T05:17:19.035745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.662804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T05:17:19.035165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.915703ms","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":"info","ts":"2026-05-30T05:17:19.035783Z","caller":"traceutil/trace.go:171","msg":"trace[685302219] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:588; }","duration":"288.737245ms","start":"2026-05-30T05:17:18.747032Z","end":"2026-05-30T05:17:19.03577Z","steps":["trace[685302219] 'agreement among raft nodes before linearized reading' (duration: 288.668013ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:17:19.035811Z","caller":"traceutil/trace.go:171","msg":"trace[1894638404] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:588; }","duration":"370.606869ms","start":"2026-05-30T05:17:18.665192Z","end":"2026-05-30T05:17:19.035799Z","steps":["trace[1894638404] 'agreement among raft nodes before linearized reading' (duration: 369.933354ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.035981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.482136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:17:19.038529Z","caller":"traceutil/trace.go:171","msg":"trace[1181533817] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:588; }","duration":"432.062715ms","start":"2026-05-30T05:17:18.606453Z","end":"2026-05-30T05:17:19.038516Z","steps":["trace[1181533817] 'agreement among raft nodes before linearized reading' (duration: 429.493956ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.038622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:18.606437Z","time spent":"432.122626ms","remote":"127.0.0.1:38540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-05-30T05:17:19.037802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:18.665164Z","time spent":"372.605094ms","remote":"127.0.0.1:38544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-05-30T05:17:19.036021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.848324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:17:19.03884Z","caller":"traceutil/trace.go:171","msg":"trace[828039608] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:588; }","duration":"432.613137ms","start":"2026-05-30T05:17:18.606148Z","end":"2026-05-30T05:17:19.038761Z","steps":["trace[828039608] 'agreement among raft nodes before linearized reading' (duration: 429.851474ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.038889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:18.606134Z","time spent":"432.73693ms","remote":"127.0.0.1:38540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-05-30T05:17:19.036053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.189771ms","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-05-30T05:17:19.039023Z","caller":"traceutil/trace.go:171","msg":"trace[1597149279] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:588; }","duration":"447.162699ms","start":"2026-05-30T05:17:18.591849Z","end":"2026-05-30T05:17:19.039011Z","steps":["trace[1597149279] 'agreement among raft nodes before linearized reading' (duration: 444.186311ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.039054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:18.591845Z","time spent":"447.19846ms","remote":"127.0.0.1:38528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-30T05:17:19.036085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.239382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:17:19.039173Z","caller":"traceutil/trace.go:171","msg":"trace[590987088] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:588; }","duration":"447.334684ms","start":"2026-05-30T05:17:18.59183Z","end":"2026-05-30T05:17:19.039165Z","steps":["trace[590987088] 'agreement among raft nodes before linearized reading' (duration: 444.238163ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.039229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:18.591825Z","time spent":"447.394515ms","remote":"127.0.0.1:38528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"warn","ts":"2026-05-30T05:17:19.03421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:18.727174Z","time spent":"307.020894ms","remote":"127.0.0.1:38568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-05-30T05:17:19.036825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.272388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:17:19.039547Z","caller":"traceutil/trace.go:171","msg":"trace[1300836261] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:588; }","duration":"292.00704ms","start":"2026-05-30T05:17:18.747527Z","end":"2026-05-30T05:17:19.039534Z","steps":["trace[1300836261] 'agreement among raft nodes before linearized reading' (duration: 289.268507ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.040646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.208952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:17:19.040706Z","caller":"traceutil/trace.go:171","msg":"trace[338873664] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:588; }","duration":"103.286653ms","start":"2026-05-30T05:17:18.937403Z","end":"2026-05-30T05:17:19.04069Z","steps":["trace[338873664] 'agreement among raft nodes before linearized reading' (duration: 103.189781ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:19.04076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:18.582782Z","time spent":"452.053303ms","remote":"127.0.0.1:39814","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18032,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:17:26.970596Z","caller":"traceutil/trace.go:171","msg":"trace[48596866] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"495.086406ms","start":"2026-05-30T05:17:26.475481Z","end":"2026-05-30T05:17:26.970567Z","steps":["trace[48596866] 'process raft request' (duration: 494.886371ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:26.970788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:26.475444Z","time spent":"495.238169ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:17:27.585206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.132189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:17:27.585311Z","caller":"traceutil/trace.go:171","msg":"trace[1361680651] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:657; }","duration":"228.323363ms","start":"2026-05-30T05:17:27.356953Z","end":"2026-05-30T05:17:27.585276Z","steps":["trace[1361680651] 'range keys from in-memory index tree' (duration: 228.029557ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:27.585504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.538511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5qzdp\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-30T05:17:27.585699Z","caller":"traceutil/trace.go:171","msg":"trace[463173890] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5qzdp; range_end:; response_count:1; response_revision:657; }","duration":"250.832408ms","start":"2026-05-30T05:17:27.334839Z","end":"2026-05-30T05:17:27.585672Z","steps":["trace[463173890] 'range keys from in-memory index tree' (duration: 250.04095ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:29.326497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.634012082s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-30T05:17:29.326991Z","caller":"traceutil/trace.go:171","msg":"trace[307394596] linearizableReadLoop","detail":"{readStateIndex:679; appliedIndex:678; }","duration":"1.166516428s","start":"2026-05-30T05:17:28.160268Z","end":"2026-05-30T05:17:29.326785Z","steps":["trace[307394596] 'read index received' (duration: 66.831µs)","trace[307394596] 'applied index is now lower than readState.Index' (duration: 1.166447907s)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:17:29.327107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.166831115s","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-05-30T05:17:29.327208Z","caller":"traceutil/trace.go:171","msg":"trace[894986159] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:658; }","duration":"1.166979789s","start":"2026-05-30T05:17:28.160194Z","end":"2026-05-30T05:17:29.327173Z","steps":["trace[894986159] 'agreement among raft nodes before linearized reading' (duration: 1.166723083s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:29.327279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:28.160162Z","time spent":"1.167106862s","remote":"127.0.0.1:40070","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-05-30T05:17:29.327365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.262218ms","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-05-30T05:17:29.327409Z","caller":"traceutil/trace.go:171","msg":"trace[1943482267] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:658; }","duration":"164.34007ms","start":"2026-05-30T05:17:29.163053Z","end":"2026-05-30T05:17:29.327393Z","steps":["trace[1943482267] 'agreement among raft nodes before linearized reading' (duration: 164.129846ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:29.32749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.554997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-30T05:17:29.32739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.712187ms","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-05-30T05:17:29.327534Z","caller":"traceutil/trace.go:171","msg":"trace[1648070538] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:658; }","duration":"352.585707ms","start":"2026-05-30T05:17:28.974929Z","end":"2026-05-30T05:17:29.327514Z","steps":["trace[1648070538] 'agreement among raft nodes before linearized reading' (duration: 352.519266ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:29.32757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:28.974851Z","time spent":"352.71218ms","remote":"127.0.0.1:40070","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-05-30T05:17:29.327566Z","caller":"traceutil/trace.go:171","msg":"trace[763706240] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:658; }","duration":"212.963452ms","start":"2026-05-30T05:17:29.11459Z","end":"2026-05-30T05:17:29.327553Z","steps":["trace[763706240] 'agreement among raft nodes before linearized reading' (duration: 212.579043ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:29.327889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"973.575234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:17:29.327934Z","caller":"traceutil/trace.go:171","msg":"trace[1151899304] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:658; }","duration":"973.647655ms","start":"2026-05-30T05:17:28.354275Z","end":"2026-05-30T05:17:29.327922Z","steps":["trace[1151899304] 'agreement among raft nodes before linearized reading' (duration: 972.878998ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:29.32797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:28.354251Z","time spent":"973.709957ms","remote":"127.0.0.1:39748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-30T05:17:46.733545Z","caller":"traceutil/trace.go:171","msg":"trace[1090536239] linearizableReadLoop","detail":"{readStateIndex:849; appliedIndex:848; }","duration":"377.178248ms","start":"2026-05-30T05:17:46.356338Z","end":"2026-05-30T05:17:46.733516Z","steps":["trace[1090536239] 'read index received' (duration: 377.033055ms)","trace[1090536239] 'applied index is now lower than readState.Index' (duration: 143.833µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:17:46.733829Z","caller":"traceutil/trace.go:171","msg":"trace[1500189510] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"762.844985ms","start":"2026-05-30T05:17:45.970926Z","end":"2026-05-30T05:17:46.73377Z","steps":["trace[1500189510] 'process raft request' (duration: 762.389855ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:46.733948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.562167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:17:46.734067Z","caller":"traceutil/trace.go:171","msg":"trace[2093885947] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:823; }","duration":"377.748101ms","start":"2026-05-30T05:17:46.356286Z","end":"2026-05-30T05:17:46.734034Z","steps":["trace[2093885947] 'agreement among raft nodes before linearized reading' (duration: 377.502936ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:46.73416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:46.356263Z","time spent":"377.880564ms","remote":"127.0.0.1:39748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-30T05:17:46.73429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:45.970901Z","time spent":"763.07931ms","remote":"127.0.0.1:39962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4948,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:17:46.851306Z","caller":"traceutil/trace.go:171","msg":"trace[568867408] linearizableReadLoop","detail":"{readStateIndex:850; appliedIndex:849; }","duration":"117.618764ms","start":"2026-05-30T05:17:46.733625Z","end":"2026-05-30T05:17:46.851244Z","steps":["trace[568867408] 'read index received' (duration: 117.324418ms)","trace[568867408] 'applied index is now lower than readState.Index' (duration: 292.896µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:17:46.851438Z","caller":"traceutil/trace.go:171","msg":"trace[2145983885] transaction","detail":"{read_only:false; response_revision:824; number_of_response:1; }","duration":"391.664176ms","start":"2026-05-30T05:17:46.459731Z","end":"2026-05-30T05:17:46.851396Z","steps":["trace[2145983885] 'process raft request' (duration: 391.259447ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:46.851594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.982221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:17:46.851728Z","caller":"traceutil/trace.go:171","msg":"trace[756289976] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:824; }","duration":"299.158215ms","start":"2026-05-30T05:17:46.552538Z","end":"2026-05-30T05:17:46.851696Z","steps":["trace[756289976] 'agreement among raft nodes before linearized reading' (duration: 298.894909ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:17:46.85173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:17:46.459691Z","time spent":"391.891651ms","remote":"127.0.0.1:40036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:17:46.852287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.212062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:17:46.85269Z","caller":"traceutil/trace.go:171","msg":"trace[1794939753] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:824; }","duration":"116.678983ms","start":"2026-05-30T05:17:46.735996Z","end":"2026-05-30T05:17:46.852675Z","steps":["trace[1794939753] 'agreement among raft nodes before linearized reading' (duration: 115.652289ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:21.91217Z","caller":"traceutil/trace.go:171","msg":"trace[788723922] linearizableReadLoop","detail":"{readStateIndex:1070; appliedIndex:1069; }","duration":"256.521194ms","start":"2026-05-30T05:18:21.655623Z","end":"2026-05-30T05:18:21.912145Z","steps":["trace[788723922] 'read index received' (duration: 256.36523ms)","trace[788723922] 'applied index is now lower than readState.Index' (duration: 154.804µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:18:21.912284Z","caller":"traceutil/trace.go:171","msg":"trace[2035989601] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"293.875993ms","start":"2026-05-30T05:18:21.618396Z","end":"2026-05-30T05:18:21.912272Z","steps":["trace[2035989601] 'process raft request' (duration: 293.543885ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:21.912502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.870152ms","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-05-30T05:18:21.912536Z","caller":"traceutil/trace.go:171","msg":"trace[558914989] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1035; }","duration":"256.962584ms","start":"2026-05-30T05:18:21.655563Z","end":"2026-05-30T05:18:21.912526Z","steps":["trace[558914989] 'agreement among raft nodes before linearized reading' (duration: 256.833121ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:22.842262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.354047ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:18:22.84239Z","caller":"traceutil/trace.go:171","msg":"trace[1681108990] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1035; }","duration":"369.49502ms","start":"2026-05-30T05:18:22.472875Z","end":"2026-05-30T05:18:22.84237Z","steps":["trace[1681108990] 'range keys from in-memory index tree' (duration: 369.336907ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:22.842665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.720112ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T05:18:22.842806Z","caller":"traceutil/trace.go:171","msg":"trace[491925465] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"926.172193ms","start":"2026-05-30T05:18:21.916625Z","end":"2026-05-30T05:18:22.842798Z","steps":["trace[491925465] 'process raft request' (duration: 926.102421ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:22.842854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:21.916605Z","time spent":"926.221854ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:18:22.843111Z","caller":"traceutil/trace.go:171","msg":"trace[1688416374] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"1.1234952s","start":"2026-05-30T05:18:21.719606Z","end":"2026-05-30T05:18:22.843101Z","steps":["trace[1688416374] 'process raft request' (duration: 643.276376ms)","trace[1688416374] 'compare' (duration: 479.264962ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:18:22.843147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:21.719573Z","time spent":"1.123553872s","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:18:22.843209Z","caller":"traceutil/trace.go:171","msg":"trace[42509412] linearizableReadLoop","detail":"{readStateIndex:1071; appliedIndex:1070; }","duration":"930.965693ms","start":"2026-05-30T05:18:21.912235Z","end":"2026-05-30T05:18:22.843201Z","steps":["trace[42509412] 'read index received' (duration: 450.656527ms)","trace[42509412] 'applied index is now lower than readState.Index' (duration: 480.308296ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:18:22.843343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.186222367s","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-05-30T05:18:22.843364Z","caller":"traceutil/trace.go:171","msg":"trace[445915126] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1037; }","duration":"1.186288239s","start":"2026-05-30T05:18:21.65707Z","end":"2026-05-30T05:18:22.843358Z","steps":["trace[445915126] 'agreement among raft nodes before linearized reading' (duration: 1.186193807s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:22.843383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:21.657043Z","time spent":"1.18633671s","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-30T05:18:22.843373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.147069768s","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-05-30T05:18:22.84343Z","caller":"traceutil/trace.go:171","msg":"trace[996670041] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1037; }","duration":"1.14717095s","start":"2026-05-30T05:18:21.696242Z","end":"2026-05-30T05:18:22.843413Z","steps":["trace[996670041] 'agreement among raft nodes before linearized reading' (duration: 1.146971266s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:22.843466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:21.696221Z","time spent":"1.147236791s","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-30T05:18:23.575813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.885709ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T05:18:23.576103Z","caller":"traceutil/trace.go:171","msg":"trace[1987446171] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"727.067494ms","start":"2026-05-30T05:18:22.849015Z","end":"2026-05-30T05:18:23.576082Z","steps":["trace[1987446171] 'process raft request' (duration: 727.023343ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:23.576173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:22.848987Z","time spent":"727.153665ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:18:23.576239Z","caller":"traceutil/trace.go:171","msg":"trace[1366700873] linearizableReadLoop","detail":"{readStateIndex:1073; appliedIndex:1072; }","duration":"732.979741ms","start":"2026-05-30T05:18:22.843221Z","end":"2026-05-30T05:18:23.576201Z","steps":["trace[1366700873] 'read index received' (duration: 399.561199ms)","trace[1366700873] 'applied index is now lower than readState.Index' (duration: 333.415902ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:18:23.576367Z","caller":"traceutil/trace.go:171","msg":"trace[1249441755] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"1.029996146s","start":"2026-05-30T05:18:22.546356Z","end":"2026-05-30T05:18:23.576352Z","steps":["trace[1249441755] 'process raft request' (duration: 696.451212ms)","trace[1249441755] 'compare' (duration: 332.415377ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:18:23.576485Z","caller":"traceutil/trace.go:171","msg":"trace[2138041645] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"728.087457ms","start":"2026-05-30T05:18:22.848383Z","end":"2026-05-30T05:18:23.576471Z","steps":["trace[2138041645] 'process raft request' (duration: 727.556775ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:23.576498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:22.54632Z","time spent":"1.030077258s","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:18:23.576503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.425547162s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T05:18:23.576545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:22.848316Z","time spent":"728.19841ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:18:23.576578Z","caller":"traceutil/trace.go:171","msg":"trace[1612334280] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1040; }","duration":"1.425691596s","start":"2026-05-30T05:18:22.150868Z","end":"2026-05-30T05:18:23.576559Z","steps":["trace[1612334280] 'agreement among raft nodes before linearized reading' (duration: 1.425549513s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:23.576622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:22.150836Z","time spent":"1.425775707s","remote":"127.0.0.1:40196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":29,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"warn","ts":"2026-05-30T05:18:23.576831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.220809172s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:18:23.576863Z","caller":"traceutil/trace.go:171","msg":"trace[710487130] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1040; }","duration":"1.220881844s","start":"2026-05-30T05:18:22.355973Z","end":"2026-05-30T05:18:23.576855Z","steps":["trace[710487130] 'agreement among raft nodes before linearized reading' (duration: 1.220813832s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:23.576885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:22.355952Z","time spent":"1.220928945s","remote":"127.0.0.1:39748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-30T05:18:23.576846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.789545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-30T05:18:23.576874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.10718343s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.138\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-30T05:18:23.576944Z","caller":"traceutil/trace.go:171","msg":"trace[289512175] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1040; }","duration":"230.966549ms","start":"2026-05-30T05:18:23.345953Z","end":"2026-05-30T05:18:23.576919Z","steps":["trace[289512175] 'agreement among raft nodes before linearized reading' (duration: 230.593841ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:23.576959Z","caller":"traceutil/trace.go:171","msg":"trace[810435974] range","detail":"{range_begin:/registry/masterleases/199.204.45.138; range_end:; response_count:1; response_revision:1040; }","duration":"1.107319763s","start":"2026-05-30T05:18:22.469615Z","end":"2026-05-30T05:18:23.576934Z","steps":["trace[810435974] 'agreement among raft nodes before linearized reading' (duration: 1.107067738s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:23.577013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:22.469593Z","time spent":"1.107411515s","remote":"127.0.0.1:39790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.138\" "} {"level":"info","ts":"2026-05-30T05:18:48.202644Z","caller":"traceutil/trace.go:171","msg":"trace[1528626043] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"119.195582ms","start":"2026-05-30T05:18:48.083413Z","end":"2026-05-30T05:18:48.202608Z","steps":["trace[1528626043] 'process raft request' (duration: 118.944406ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:49.316871Z","caller":"traceutil/trace.go:171","msg":"trace[1670031933] linearizableReadLoop","detail":"{readStateIndex:1164; appliedIndex:1163; }","duration":"292.857229ms","start":"2026-05-30T05:18:49.023985Z","end":"2026-05-30T05:18:49.316842Z","steps":["trace[1670031933] 'read index received' (duration: 292.49337ms)","trace[1670031933] 'applied index is now lower than readState.Index' (duration: 362.579µs)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:18:49.317123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.110874ms","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-05-30T05:18:49.317129Z","caller":"traceutil/trace.go:171","msg":"trace[726796890] transaction","detail":"{read_only:false; response_revision:1123; number_of_response:1; }","duration":"314.668395ms","start":"2026-05-30T05:18:49.002413Z","end":"2026-05-30T05:18:49.317082Z","steps":["trace[726796890] 'process raft request' (duration: 314.180614ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:49.317173Z","caller":"traceutil/trace.go:171","msg":"trace[1372720684] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1123; }","duration":"293.201217ms","start":"2026-05-30T05:18:49.023955Z","end":"2026-05-30T05:18:49.317156Z","steps":["trace[1372720684] 'agreement among raft nodes before linearized reading' (duration: 293.002331ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:49.317287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:49.002388Z","time spent":"314.80797ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:18:50.031102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.539917ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T05:18:50.031208Z","caller":"traceutil/trace.go:171","msg":"trace[553355380] linearizableReadLoop","detail":"{readStateIndex:1165; appliedIndex:1164; }","duration":"675.102143ms","start":"2026-05-30T05:18:49.35609Z","end":"2026-05-30T05:18:50.031192Z","steps":["trace[553355380] 'read index received' (duration: 167.249668ms)","trace[553355380] 'applied index is now lower than readState.Index' (duration: 507.850775ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:18:50.031319Z","caller":"traceutil/trace.go:171","msg":"trace[612913494] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"709.923482ms","start":"2026-05-30T05:18:49.321384Z","end":"2026-05-30T05:18:50.031308Z","steps":["trace[612913494] 'process raft request' (duration: 202.065758ms)","trace[612913494] 'compare' (duration: 507.423644ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:18:50.031373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:49.321271Z","time spent":"710.070385ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:18:50.031442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.867257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T05:18:50.031517Z","caller":"traceutil/trace.go:171","msg":"trace[1578922517] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1124; }","duration":"434.997892ms","start":"2026-05-30T05:18:49.596502Z","end":"2026-05-30T05:18:50.0315Z","steps":["trace[1578922517] 'agreement among raft nodes before linearized reading' (duration: 434.849177ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:50.031553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:49.596479Z","time spent":"435.066293ms","remote":"127.0.0.1:40074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":3,"response size":31,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-05-30T05:18:50.031866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.78409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:18:50.032106Z","caller":"traceutil/trace.go:171","msg":"trace[81090773] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1124; }","duration":"676.057265ms","start":"2026-05-30T05:18:49.35604Z","end":"2026-05-30T05:18:50.032097Z","steps":["trace[81090773] 'agreement among raft nodes before linearized reading' (duration: 675.785909ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:50.032136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:49.356012Z","time spent":"676.115877ms","remote":"127.0.0.1:39748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-30T05:18:50.032237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.366352ms","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-05-30T05:18:50.032279Z","caller":"traceutil/trace.go:171","msg":"trace[1824517659] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1124; }","duration":"319.479935ms","start":"2026-05-30T05:18:49.712788Z","end":"2026-05-30T05:18:50.032268Z","steps":["trace[1824517659] 'agreement among raft nodes before linearized reading' (duration: 319.339012ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:50.032329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:49.71275Z","time spent":"319.572627ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-30T05:18:50.032286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.453294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-30T05:18:50.032405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.488243ms","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-05-30T05:18:50.032453Z","caller":"traceutil/trace.go:171","msg":"trace[804953394] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1124; }","duration":"368.646499ms","start":"2026-05-30T05:18:49.663784Z","end":"2026-05-30T05:18:50.03243Z","steps":["trace[804953394] 'agreement among raft nodes before linearized reading' (duration: 368.473445ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:50.032403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.440327ms","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-05-30T05:18:50.032515Z","caller":"traceutil/trace.go:171","msg":"trace[213383931] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1124; }","duration":"311.623911ms","start":"2026-05-30T05:18:49.720886Z","end":"2026-05-30T05:18:50.03251Z","steps":["trace[213383931] 'agreement among raft nodes before linearized reading' (duration: 311.388326ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:50.032549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:49.720859Z","time spent":"311.680923ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-30T05:18:50.032551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:49.663747Z","time spent":"368.769402ms","remote":"127.0.0.1:39962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":31,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"info","ts":"2026-05-30T05:18:50.03248Z","caller":"traceutil/trace.go:171","msg":"trace[756403809] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1124; }","duration":"297.630266ms","start":"2026-05-30T05:18:49.734833Z","end":"2026-05-30T05:18:50.032463Z","steps":["trace[756403809] 'agreement among raft nodes before linearized reading' (duration: 297.427952ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:50.179635Z","caller":"traceutil/trace.go:171","msg":"trace[2072631091] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"141.527055ms","start":"2026-05-30T05:18:50.038084Z","end":"2026-05-30T05:18:50.179611Z","steps":["trace[2072631091] 'process raft request' (duration: 141.478504ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:50.179849Z","caller":"traceutil/trace.go:171","msg":"trace[1805889214] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"142.715472ms","start":"2026-05-30T05:18:50.037101Z","end":"2026-05-30T05:18:50.179816Z","steps":["trace[1805889214] 'process raft request' (duration: 125.574148ms)","trace[1805889214] 'compare' (duration: 16.722635ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:18:50.969826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.615104ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T05:18:50.969946Z","caller":"traceutil/trace.go:171","msg":"trace[985852614] linearizableReadLoop","detail":"{readStateIndex:1169; appliedIndex:1168; }","duration":"613.519724ms","start":"2026-05-30T05:18:50.356406Z","end":"2026-05-30T05:18:50.969926Z","steps":["trace[985852614] 'read index received' (duration: 432.699194ms)","trace[985852614] 'applied index is now lower than readState.Index' (duration: 180.81881ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:18:50.970049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.652367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:18:50.970121Z","caller":"traceutil/trace.go:171","msg":"trace[1924321331] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1128; }","duration":"613.724399ms","start":"2026-05-30T05:18:50.356344Z","end":"2026-05-30T05:18:50.970068Z","steps":["trace[1924321331] 'agreement among raft nodes before linearized reading' (duration: 613.633446ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:50.970158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:50.356321Z","time spent":"613.82694ms","remote":"127.0.0.1:39748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-30T05:18:50.970528Z","caller":"traceutil/trace.go:171","msg":"trace[2025762943] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"758.718443ms","start":"2026-05-30T05:18:50.211793Z","end":"2026-05-30T05:18:50.970512Z","steps":["trace[2025762943] 'process raft request' (duration: 577.308709ms)","trace[2025762943] 'compare' (duration: 180.387049ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:18:50.970609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:50.211777Z","time spent":"758.793995ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:18:51.481271Z","caller":"traceutil/trace.go:171","msg":"trace[1929817913] linearizableReadLoop","detail":"{readStateIndex:1170; appliedIndex:1169; }","duration":"124.707779ms","start":"2026-05-30T05:18:51.356522Z","end":"2026-05-30T05:18:51.48123Z","steps":["trace[1929817913] 'read index received' (duration: 121.71808ms)","trace[1929817913] 'applied index is now lower than readState.Index' (duration: 2.986888ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:18:51.481539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.005256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:18:51.481577Z","caller":"traceutil/trace.go:171","msg":"trace[131909726] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1129; }","duration":"125.104838ms","start":"2026-05-30T05:18:51.356461Z","end":"2026-05-30T05:18:51.481566Z","steps":["trace[131909726] 'agreement among raft nodes before linearized reading' (duration: 124.979745ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:51.482027Z","caller":"traceutil/trace.go:171","msg":"trace[405174190] transaction","detail":"{read_only:false; response_revision:1129; number_of_response:1; }","duration":"159.213662ms","start":"2026-05-30T05:18:51.322797Z","end":"2026-05-30T05:18:51.48201Z","steps":["trace[405174190] 'process raft request' (duration: 155.536758ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:52.576652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.994377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-30T05:18:52.57667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.751569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.138\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-30T05:18:52.576739Z","caller":"traceutil/trace.go:171","msg":"trace[840588830] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1130; }","duration":"392.11955ms","start":"2026-05-30T05:18:52.184604Z","end":"2026-05-30T05:18:52.576723Z","steps":["trace[840588830] 'range keys from in-memory index tree' (duration: 391.835464ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:52.576767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:52.184593Z","time spent":"392.168881ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-30T05:18:52.576773Z","caller":"traceutil/trace.go:171","msg":"trace[1368951270] range","detail":"{range_begin:/registry/masterleases/199.204.45.138; range_end:; response_count:1; response_revision:1130; }","duration":"104.917023ms","start":"2026-05-30T05:18:52.471831Z","end":"2026-05-30T05:18:52.576748Z","steps":["trace[1368951270] 'range keys from in-memory index tree' (duration: 104.508914ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:52.576724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.197977ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T05:18:52.576778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.848903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:18:52.576835Z","caller":"traceutil/trace.go:171","msg":"trace[598001158] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1130; }","duration":"104.315849ms","start":"2026-05-30T05:18:52.472502Z","end":"2026-05-30T05:18:52.576818Z","steps":["trace[598001158] 'range keys from in-memory index tree' (duration: 104.186167ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:52.576852Z","caller":"traceutil/trace.go:171","msg":"trace[1384095632] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1130; }","duration":"221.960416ms","start":"2026-05-30T05:18:52.354874Z","end":"2026-05-30T05:18:52.576834Z","steps":["trace[1384095632] 'range keys from in-memory index tree' (duration: 221.781892ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:52.576897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.570581ms","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-05-30T05:18:52.576974Z","caller":"traceutil/trace.go:171","msg":"trace[1747125010] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1130; }","duration":"392.686413ms","start":"2026-05-30T05:18:52.184275Z","end":"2026-05-30T05:18:52.576961Z","steps":["trace[1747125010] 'range keys from in-memory index tree' (duration: 392.369545ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:52.576822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.938842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-30T05:18:52.577036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:52.184258Z","time spent":"392.767735ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-30T05:18:52.577082Z","caller":"traceutil/trace.go:171","msg":"trace[1124301029] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1130; }","duration":"454.206538ms","start":"2026-05-30T05:18:52.122825Z","end":"2026-05-30T05:18:52.577032Z","steps":["trace[1124301029] 'range keys from in-memory index tree' (duration: 453.813369ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:52.577168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:52.122805Z","time spent":"454.31342ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-30T05:18:52.927602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:52.57837Z","time spent":"349.227992ms","remote":"127.0.0.1:39790","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-30T05:18:53.789171Z","caller":"traceutil/trace.go:171","msg":"trace[558164426] linearizableReadLoop","detail":"{readStateIndex:1175; appliedIndex:1171; }","duration":"895.273825ms","start":"2026-05-30T05:18:52.893825Z","end":"2026-05-30T05:18:53.789099Z","steps":["trace[558164426] 'read index received' (duration: 33.627154ms)","trace[558164426] 'applied index is now lower than readState.Index' (duration: 861.645401ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:18:53.789321Z","caller":"traceutil/trace.go:171","msg":"trace[1634448720] transaction","detail":"{read_only:false; response_revision:1131; number_of_response:1; }","duration":"1.207597768s","start":"2026-05-30T05:18:52.581704Z","end":"2026-05-30T05:18:53.789302Z","steps":["trace[1634448720] 'process raft request' (duration: 1.207062246s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:53.789464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:52.581679Z","time spent":"1.20768027s","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:18:53.7897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"895.871438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:18:53.789751Z","caller":"traceutil/trace.go:171","msg":"trace[1128712251] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1133; }","duration":"895.96469ms","start":"2026-05-30T05:18:52.893769Z","end":"2026-05-30T05:18:53.789734Z","steps":["trace[1128712251] 'agreement among raft nodes before linearized reading' (duration: 895.866688ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:53.789788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:52.893749Z","time spent":"896.026991ms","remote":"127.0.0.1:36122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-05-30T05:18:53.789778Z","caller":"traceutil/trace.go:171","msg":"trace[1061743807] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"1.20678297s","start":"2026-05-30T05:18:52.582934Z","end":"2026-05-30T05:18:53.789717Z","steps":["trace[1061743807] 'process raft request' (duration: 1.206115565s)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:53.790334Z","caller":"traceutil/trace.go:171","msg":"trace[1466249602] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"1.207930976s","start":"2026-05-30T05:18:52.582392Z","end":"2026-05-30T05:18:53.790323Z","steps":["trace[1466249602] 'process raft request' (duration: 1.206611516s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:53.790413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:52.582381Z","time spent":"1.207993188s","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:18:53.790395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:52.582921Z","time spent":"1.207285871s","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:18:54.305666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.981243ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T05:18:54.305985Z","caller":"traceutil/trace.go:171","msg":"trace[1259618523] transaction","detail":"{read_only:false; response_revision:1136; number_of_response:1; }","duration":"513.972123ms","start":"2026-05-30T05:18:53.791992Z","end":"2026-05-30T05:18:54.305964Z","steps":["trace[1259618523] 'process raft request' (duration: 513.927552ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:54.306082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:53.791968Z","time spent":"514.079285ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:18:54.306354Z","caller":"traceutil/trace.go:171","msg":"trace[550369743] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"815.873387ms","start":"2026-05-30T05:18:53.490459Z","end":"2026-05-30T05:18:54.306332Z","steps":["trace[550369743] 'process raft request' (duration: 815.350016ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:54.306451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:53.490436Z","time spent":"815.969271ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:18:54.306428Z","caller":"traceutil/trace.go:171","msg":"trace[933847394] transaction","detail":"{read_only:false; response_revision:1134; number_of_response:1; }","duration":"1.377253932s","start":"2026-05-30T05:18:52.929135Z","end":"2026-05-30T05:18:54.306389Z","steps":["trace[933847394] 'process raft request' (duration: 992.45552ms)","trace[933847394] 'compare' (duration: 383.850389ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:18:54.306406Z","caller":"traceutil/trace.go:171","msg":"trace[520222188] linearizableReadLoop","detail":"{readStateIndex:1177; appliedIndex:1175; }","duration":"517.105626ms","start":"2026-05-30T05:18:53.789254Z","end":"2026-05-30T05:18:54.30636Z","steps":["trace[520222188] 'read index received' (duration: 132.357055ms)","trace[520222188] 'applied index is now lower than readState.Index' (duration: 384.742981ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:18:54.306515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"967.932186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:18:54.306585Z","caller":"traceutil/trace.go:171","msg":"trace[393492563] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1136; }","duration":"968.052629ms","start":"2026-05-30T05:18:53.338516Z","end":"2026-05-30T05:18:54.306568Z","steps":["trace[393492563] 'agreement among raft nodes before linearized reading' (duration: 967.941826ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:54.306597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:52.929103Z","time spent":"1.377405545s","remote":"127.0.0.1:39790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:18:54.306627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:53.338485Z","time spent":"968.132891ms","remote":"127.0.0.1:36142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-30T05:18:54.306507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"950.69239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:18:54.306685Z","caller":"traceutil/trace.go:171","msg":"trace[227629615] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1136; }","duration":"950.935005ms","start":"2026-05-30T05:18:53.355737Z","end":"2026-05-30T05:18:54.306672Z","steps":["trace[227629615] 'agreement among raft nodes before linearized reading' (duration: 950.682649ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:54.30673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:53.355705Z","time spent":"951.015657ms","remote":"127.0.0.1:39748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-30T05:18:54.306985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.331077578s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-05-30T05:18:54.306986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.440173ms","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-05-30T05:18:54.307141Z","caller":"traceutil/trace.go:171","msg":"trace[1526271132] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1136; }","duration":"241.575947ms","start":"2026-05-30T05:18:54.065473Z","end":"2026-05-30T05:18:54.307049Z","steps":["trace[1526271132] 'agreement among raft nodes before linearized reading' (duration: 241.29131ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:54.307062Z","caller":"traceutil/trace.go:171","msg":"trace[1518527597] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1136; }","duration":"1.331206331s","start":"2026-05-30T05:18:52.97583Z","end":"2026-05-30T05:18:54.307036Z","steps":["trace[1518527597] 'agreement among raft nodes before linearized reading' (duration: 1.330757391s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:54.307861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:52.975806Z","time spent":"1.331892577s","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-30T05:18:54.609159Z","caller":"traceutil/trace.go:171","msg":"trace[601430884] linearizableReadLoop","detail":"{readStateIndex:1180; appliedIndex:1178; }","duration":"295.58259ms","start":"2026-05-30T05:18:54.313554Z","end":"2026-05-30T05:18:54.609136Z","steps":["trace[601430884] 'read index received' (duration: 291.035045ms)","trace[601430884] 'applied index is now lower than readState.Index' (duration: 4.545925ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:18:54.609191Z","caller":"traceutil/trace.go:171","msg":"trace[177041670] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"296.249365ms","start":"2026-05-30T05:18:54.312926Z","end":"2026-05-30T05:18:54.609175Z","steps":["trace[177041670] 'process raft request' (duration: 296.116652ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:54.609205Z","caller":"traceutil/trace.go:171","msg":"trace[320694619] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"296.417349ms","start":"2026-05-30T05:18:54.312767Z","end":"2026-05-30T05:18:54.609184Z","steps":["trace[320694619] 'process raft request' (duration: 291.813982ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:54.609313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.513139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:18:54.609344Z","caller":"traceutil/trace.go:171","msg":"trace[1826623693] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1138; }","duration":"252.610361ms","start":"2026-05-30T05:18:54.356724Z","end":"2026-05-30T05:18:54.609335Z","steps":["trace[1826623693] 'agreement among raft nodes before linearized reading' (duration: 252.532409ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:54.60938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.796104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-05-30T05:18:54.609495Z","caller":"traceutil/trace.go:171","msg":"trace[2119900481] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1138; }","duration":"295.931618ms","start":"2026-05-30T05:18:54.313528Z","end":"2026-05-30T05:18:54.60946Z","steps":["trace[2119900481] 'agreement among raft nodes before linearized reading' (duration: 295.717823ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:55.950743Z","caller":"traceutil/trace.go:171","msg":"trace[1874310745] transaction","detail":"{read_only:false; response_revision:1139; number_of_response:1; }","duration":"149.494459ms","start":"2026-05-30T05:18:55.801225Z","end":"2026-05-30T05:18:55.95072Z","steps":["trace[1874310745] 'process raft request' (duration: 149.326545ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:55.962456Z","caller":"traceutil/trace.go:171","msg":"trace[1154580903] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"161.056035ms","start":"2026-05-30T05:18:55.801378Z","end":"2026-05-30T05:18:55.962434Z","steps":["trace[1154580903] 'process raft request' (duration: 161.007084ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:55.962757Z","caller":"traceutil/trace.go:171","msg":"trace[2146231177] transaction","detail":"{read_only:false; response_revision:1140; number_of_response:1; }","duration":"161.406773ms","start":"2026-05-30T05:18:55.80131Z","end":"2026-05-30T05:18:55.962717Z","steps":["trace[2146231177] 'process raft request' (duration: 160.962463ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:04.781614Z","caller":"traceutil/trace.go:171","msg":"trace[1042362902] transaction","detail":"{read_only:false; response_revision:1171; number_of_response:1; }","duration":"118.905816ms","start":"2026-05-30T05:19:04.662681Z","end":"2026-05-30T05:19:04.781587Z","steps":["trace[1042362902] 'process raft request' (duration: 81.30628ms)","trace[1042362902] 'compare' (duration: 37.473813ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:19:09.991095Z","caller":"traceutil/trace.go:171","msg":"trace[218296610] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"174.624246ms","start":"2026-05-30T05:19:09.816446Z","end":"2026-05-30T05:19:09.99107Z","steps":["trace[218296610] 'process raft request' (duration: 174.477073ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:13.404002Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726609342606751,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-30T05:19:13.797479Z","caller":"traceutil/trace.go:171","msg":"trace[1460931027] linearizableReadLoop","detail":"{readStateIndex:1295; appliedIndex:1294; }","duration":"894.082207ms","start":"2026-05-30T05:19:12.903369Z","end":"2026-05-30T05:19:13.797451Z","steps":["trace[1460931027] 'read index received' (duration: 893.830761ms)","trace[1460931027] 'applied index is now lower than readState.Index' (duration: 250.166µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:19:13.797638Z","caller":"traceutil/trace.go:171","msg":"trace[327330642] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"982.289985ms","start":"2026-05-30T05:19:12.81533Z","end":"2026-05-30T05:19:13.79762Z","steps":["trace[327330642] 'process raft request' (duration: 981.897506ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:13.797776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:12.81531Z","time spent":"982.359187ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:19:13.797885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.163319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:19:13.797942Z","caller":"traceutil/trace.go:171","msg":"trace[1866563150] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1247; }","duration":"438.267382ms","start":"2026-05-30T05:19:13.359662Z","end":"2026-05-30T05:19:13.797929Z","steps":["trace[1866563150] 'agreement among raft nodes before linearized reading' (duration: 438.17328ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:13.797973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:13.359634Z","time spent":"438.330963ms","remote":"127.0.0.1:39748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-30T05:19:13.79823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"894.859314ms","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-05-30T05:19:13.798258Z","caller":"traceutil/trace.go:171","msg":"trace[40520873] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1247; }","duration":"894.934736ms","start":"2026-05-30T05:19:12.903315Z","end":"2026-05-30T05:19:13.798249Z","steps":["trace[40520873] 'agreement among raft nodes before linearized reading' (duration: 894.806873ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:13.798282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:12.903287Z","time spent":"894.989188ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-30T05:19:14.409806Z","caller":"traceutil/trace.go:171","msg":"trace[2012759733] linearizableReadLoop","detail":"{readStateIndex:1296; appliedIndex:1295; }","duration":"279.195433ms","start":"2026-05-30T05:19:14.130563Z","end":"2026-05-30T05:19:14.409758Z","steps":["trace[2012759733] 'read index received' (duration: 272.403837ms)","trace[2012759733] 'applied index is now lower than readState.Index' (duration: 6.788676ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:19:14.409855Z","caller":"traceutil/trace.go:171","msg":"trace[1339400333] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"606.655945ms","start":"2026-05-30T05:19:13.803147Z","end":"2026-05-30T05:19:14.409803Z","steps":["trace[1339400333] 'process raft request' (duration: 599.888659ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:14.410111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:13.803128Z","time spent":"606.822849ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:19:14.410157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.36031ms","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-05-30T05:19:14.410221Z","caller":"traceutil/trace.go:171","msg":"trace[830337715] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1248; }","duration":"260.471432ms","start":"2026-05-30T05:19:14.149733Z","end":"2026-05-30T05:19:14.410204Z","steps":["trace[830337715] 'agreement among raft nodes before linearized reading' (duration: 260.306459ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:14.410326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.411126ms","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-05-30T05:19:14.410379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.816227ms","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-05-30T05:19:14.410399Z","caller":"traceutil/trace.go:171","msg":"trace[1292321124] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1248; }","duration":"225.536408ms","start":"2026-05-30T05:19:14.184842Z","end":"2026-05-30T05:19:14.410379Z","steps":["trace[1292321124] 'agreement among raft nodes before linearized reading' (duration: 225.207941ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:14.410411Z","caller":"traceutil/trace.go:171","msg":"trace[1649179169] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1248; }","duration":"279.898799ms","start":"2026-05-30T05:19:14.130503Z","end":"2026-05-30T05:19:14.410402Z","steps":["trace[1649179169] 'agreement among raft nodes before linearized reading' (duration: 279.354577ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:18.566816Z","caller":"traceutil/trace.go:171","msg":"trace[274620192] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"116.279735ms","start":"2026-05-30T05:19:18.450505Z","end":"2026-05-30T05:19:18.566784Z","steps":["trace[274620192] 'process raft request' (duration: 116.228074ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:18.566854Z","caller":"traceutil/trace.go:171","msg":"trace[676153528] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"116.411328ms","start":"2026-05-30T05:19:18.450396Z","end":"2026-05-30T05:19:18.566807Z","steps":["trace[676153528] 'process raft request' (duration: 116.214754ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:18.567056Z","caller":"traceutil/trace.go:171","msg":"trace[854747678] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"115.271661ms","start":"2026-05-30T05:19:18.451778Z","end":"2026-05-30T05:19:18.567049Z","steps":["trace[854747678] 'process raft request' (duration: 114.980285ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:35.029483Z","caller":"traceutil/trace.go:171","msg":"trace[327239227] transaction","detail":"{read_only:false; response_revision:1345; number_of_response:1; }","duration":"205.794404ms","start":"2026-05-30T05:19:34.82366Z","end":"2026-05-30T05:19:35.029454Z","steps":["trace[327239227] 'process raft request' (duration: 164.608237ms)","trace[327239227] 'compare' (duration: 41.035323ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:19:36.981567Z","caller":"traceutil/trace.go:171","msg":"trace[1454221756] linearizableReadLoop","detail":"{readStateIndex:1407; appliedIndex:1406; }","duration":"334.662498ms","start":"2026-05-30T05:19:36.646866Z","end":"2026-05-30T05:19:36.981528Z","steps":["trace[1454221756] 'read index received' (duration: 334.480324ms)","trace[1454221756] 'applied index is now lower than readState.Index' (duration: 180.624µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:19:36.981726Z","caller":"traceutil/trace.go:171","msg":"trace[1461492633] transaction","detail":"{read_only:false; response_revision:1355; number_of_response:1; }","duration":"388.904616ms","start":"2026-05-30T05:19:36.592776Z","end":"2026-05-30T05:19:36.98168Z","steps":["trace[1461492633] 'process raft request' (duration: 388.551378ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:36.981791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.891823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:19:36.981843Z","caller":"traceutil/trace.go:171","msg":"trace[1377639791] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1355; }","duration":"334.969405ms","start":"2026-05-30T05:19:36.646854Z","end":"2026-05-30T05:19:36.981824Z","steps":["trace[1377639791] 'agreement among raft nodes before linearized reading' (duration: 334.857912ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:36.981888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:36.646783Z","time spent":"335.092828ms","remote":"127.0.0.1:55774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-30T05:19:36.981921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:36.592756Z","time spent":"389.06211ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:19:37.591778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.715469ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T05:19:37.59194Z","caller":"traceutil/trace.go:171","msg":"trace[372901183] linearizableReadLoop","detail":"{readStateIndex:1408; appliedIndex:1407; }","duration":"610.241528ms","start":"2026-05-30T05:19:36.981672Z","end":"2026-05-30T05:19:37.591914Z","steps":["trace[372901183] 'read index received' (duration: 212.09914ms)","trace[372901183] 'applied index is now lower than readState.Index' (duration: 398.140418ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:19:37.592198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.074101ms","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-05-30T05:19:37.592234Z","caller":"traceutil/trace.go:171","msg":"trace[1758696300] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1356; }","duration":"759.154123ms","start":"2026-05-30T05:19:36.833069Z","end":"2026-05-30T05:19:37.592223Z","steps":["trace[1758696300] 'agreement among raft nodes before linearized reading' (duration: 758.945688ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:37.592178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.574928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-30T05:19:37.592275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:36.833048Z","time spent":"759.216525ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-30T05:19:37.592319Z","caller":"traceutil/trace.go:171","msg":"trace[985792696] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1356; }","duration":"661.792923ms","start":"2026-05-30T05:19:36.930506Z","end":"2026-05-30T05:19:37.592299Z","steps":["trace[985792696] 'agreement among raft nodes before linearized reading' (duration: 661.492607ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:37.59232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.428313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-30T05:19:37.592411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:36.930485Z","time spent":"661.913836ms","remote":"127.0.0.1:39874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":5,"response size":31,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"info","ts":"2026-05-30T05:19:37.592422Z","caller":"traceutil/trace.go:171","msg":"trace[118186712] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1356; }","duration":"800.571666ms","start":"2026-05-30T05:19:36.791821Z","end":"2026-05-30T05:19:37.592393Z","steps":["trace[118186712] 'agreement among raft nodes before linearized reading' (duration: 800.254128ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:37.592436Z","caller":"traceutil/trace.go:171","msg":"trace[1628666124] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"848.445548ms","start":"2026-05-30T05:19:36.743513Z","end":"2026-05-30T05:19:37.591958Z","steps":["trace[1628666124] 'process raft request' (duration: 450.33901ms)","trace[1628666124] 'compare' (duration: 397.516314ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:19:37.59249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:36.791805Z","time spent":"800.671488ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-30T05:19:37.592915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:36.743489Z","time spent":"849.090032ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:19:37.655366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.113155ms","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-05-30T05:19:37.655477Z","caller":"traceutil/trace.go:171","msg":"trace[2112542007] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1358; }","duration":"244.262179ms","start":"2026-05-30T05:19:37.411181Z","end":"2026-05-30T05:19:37.655443Z","steps":["trace[2112542007] 'agreement among raft nodes before linearized reading' (duration: 244.030813ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:37.655486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.876795ms","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-05-30T05:19:37.655571Z","caller":"traceutil/trace.go:171","msg":"trace[393040593] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1358; }","duration":"622.031859ms","start":"2026-05-30T05:19:37.033518Z","end":"2026-05-30T05:19:37.655549Z","steps":["trace[393040593] 'agreement among raft nodes before linearized reading' (duration: 621.698111ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:37.655611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:37.033485Z","time spent":"622.11953ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-30T05:19:39.241978Z","caller":"traceutil/trace.go:171","msg":"trace[857216095] linearizableReadLoop","detail":"{readStateIndex:1415; appliedIndex:1414; }","duration":"254.810822ms","start":"2026-05-30T05:19:38.987136Z","end":"2026-05-30T05:19:39.241947Z","steps":["trace[857216095] 'read index received' (duration: 254.475564ms)","trace[857216095] 'applied index is now lower than readState.Index' (duration: 333.748µs)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:19:39.242224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.061127ms","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-05-30T05:19:39.242268Z","caller":"traceutil/trace.go:171","msg":"trace[320974637] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1362; }","duration":"255.17304ms","start":"2026-05-30T05:19:38.987079Z","end":"2026-05-30T05:19:39.242252Z","steps":["trace[320974637] 'agreement among raft nodes before linearized reading' (duration: 254.991086ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:39.242337Z","caller":"traceutil/trace.go:171","msg":"trace[769658716] transaction","detail":"{read_only:false; response_revision:1362; number_of_response:1; }","duration":"473.867391ms","start":"2026-05-30T05:19:38.768414Z","end":"2026-05-30T05:19:39.242282Z","steps":["trace[769658716] 'process raft request' (duration: 473.330248ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:39.242583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:38.768387Z","time spent":"474.086155ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:19:40.152172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.991909ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T05:19:40.152295Z","caller":"traceutil/trace.go:171","msg":"trace[1651016387] linearizableReadLoop","detail":"{readStateIndex:1416; appliedIndex:1415; }","duration":"794.933206ms","start":"2026-05-30T05:19:39.357337Z","end":"2026-05-30T05:19:40.152271Z","steps":["trace[1651016387] 'read index received' (duration: 162.629991ms)","trace[1651016387] 'applied index is now lower than readState.Index' (duration: 632.301625ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:19:40.152374Z","caller":"traceutil/trace.go:171","msg":"trace[1740833782] transaction","detail":"{read_only:false; response_revision:1363; number_of_response:1; }","duration":"903.400081ms","start":"2026-05-30T05:19:39.248936Z","end":"2026-05-30T05:19:40.152336Z","steps":["trace[1740833782] 'process raft request' (duration: 271.142736ms)","trace[1740833782] 'compare' (duration: 631.857526ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:19:40.152408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"795.079199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:19:40.152452Z","caller":"traceutil/trace.go:171","msg":"trace[9947513] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1363; }","duration":"795.164471ms","start":"2026-05-30T05:19:39.357276Z","end":"2026-05-30T05:19:40.152441Z","steps":["trace[9947513] 'agreement among raft nodes before linearized reading' (duration: 795.09629ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:40.152485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:39.357255Z","time spent":"795.222483ms","remote":"127.0.0.1:39748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-30T05:19:40.152541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:39.248898Z","time spent":"903.549174ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:19:40.598516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.145069ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T05:19:40.598635Z","caller":"traceutil/trace.go:171","msg":"trace[139684061] linearizableReadLoop","detail":"{readStateIndex:1417; appliedIndex:1416; }","duration":"446.275285ms","start":"2026-05-30T05:19:40.15234Z","end":"2026-05-30T05:19:40.598615Z","steps":["trace[139684061] 'read index received' (duration: 140.916041ms)","trace[139684061] 'applied index is now lower than readState.Index' (duration: 305.357454ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:19:40.598741Z","caller":"traceutil/trace.go:171","msg":"trace[787022696] transaction","detail":"{read_only:false; response_revision:1364; number_of_response:1; }","duration":"999.635334ms","start":"2026-05-30T05:19:39.599091Z","end":"2026-05-30T05:19:40.598727Z","steps":["trace[787022696] 'process raft request' (duration: 694.168437ms)","trace[787022696] 'compare' (duration: 304.910944ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:19:40.598801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:39.599065Z","time spent":"999.703546ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:19:40.598981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.195780736s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T05:19:40.599013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"932.884759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-30T05:19:40.599072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.17456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T05:19:40.599102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"936.994924ms","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-05-30T05:19:40.599127Z","caller":"traceutil/trace.go:171","msg":"trace[289899494] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1364; }","duration":"937.063146ms","start":"2026-05-30T05:19:39.662059Z","end":"2026-05-30T05:19:40.599122Z","steps":["trace[289899494] 'agreement among raft nodes before linearized reading' (duration: 936.988293ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:40.599129Z","caller":"traceutil/trace.go:171","msg":"trace[858021788] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1364; }","duration":"445.269753ms","start":"2026-05-30T05:19:40.15385Z","end":"2026-05-30T05:19:40.59912Z","steps":["trace[858021788] 'agreement among raft nodes before linearized reading' (duration: 445.145699ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:40.599147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:39.662034Z","time spent":"937.108737ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-30T05:19:40.599158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:40.15383Z","time spent":"445.320433ms","remote":"127.0.0.1:39758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-30T05:19:40.59916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"849.90067ms","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-05-30T05:19:40.59908Z","caller":"traceutil/trace.go:171","msg":"trace[1328411673] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1364; }","duration":"932.998382ms","start":"2026-05-30T05:19:39.666072Z","end":"2026-05-30T05:19:40.59907Z","steps":["trace[1328411673] 'agreement among raft nodes before linearized reading' (duration: 932.814907ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:40.599191Z","caller":"traceutil/trace.go:171","msg":"trace[648677280] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1364; }","duration":"849.993033ms","start":"2026-05-30T05:19:39.749187Z","end":"2026-05-30T05:19:40.59918Z","steps":["trace[648677280] 'agreement among raft nodes before linearized reading' (duration: 849.914541ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:40.599203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:39.666051Z","time spent":"933.147796ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-30T05:19:40.599217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:39.749157Z","time spent":"850.054295ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-30T05:19:40.599029Z","caller":"traceutil/trace.go:171","msg":"trace[1934039754] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1364; }","duration":"1.195891998s","start":"2026-05-30T05:19:39.403124Z","end":"2026-05-30T05:19:40.599016Z","steps":["trace[1934039754] 'agreement among raft nodes before linearized reading' (duration: 1.195816807s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:40.59927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:39.403091Z","time spent":"1.196173046s","remote":"127.0.0.1:36128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-05-30T05:19:40.599278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.263467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-05-30T05:19:40.599317Z","caller":"traceutil/trace.go:171","msg":"trace[868866624] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1364; }","duration":"400.38131ms","start":"2026-05-30T05:19:40.198921Z","end":"2026-05-30T05:19:40.599303Z","steps":["trace[868866624] 'agreement among raft nodes before linearized reading' (duration: 400.283378ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:40.599349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:40.198885Z","time spent":"400.456992ms","remote":"127.0.0.1:39844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":142,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"warn","ts":"2026-05-30T05:19:40.59901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"843.895722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:19:40.599388Z","caller":"traceutil/trace.go:171","msg":"trace[1742175667] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1364; }","duration":"844.331422ms","start":"2026-05-30T05:19:39.755047Z","end":"2026-05-30T05:19:40.599378Z","steps":["trace[1742175667] 'agreement among raft nodes before linearized reading' (duration: 843.881801ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:40.599398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.510356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:119561"} {"level":"info","ts":"2026-05-30T05:19:40.599436Z","caller":"traceutil/trace.go:171","msg":"trace[506181057] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1364; }","duration":"404.549807ms","start":"2026-05-30T05:19:40.194878Z","end":"2026-05-30T05:19:40.599428Z","steps":["trace[506181057] 'agreement among raft nodes before linearized reading' (duration: 404.423564ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:40.599461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:40.194795Z","time spent":"404.659359ms","remote":"127.0.0.1:39828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":119585,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-05-30T05:19:40.599465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.859063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-05-30T05:19:40.59941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:39.755025Z","time spent":"844.377844ms","remote":"127.0.0.1:38540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-05-30T05:19:40.599073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.46625ms","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-05-30T05:19:40.599522Z","caller":"traceutil/trace.go:171","msg":"trace[1069434634] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1364; }","duration":"437.963095ms","start":"2026-05-30T05:19:40.161545Z","end":"2026-05-30T05:19:40.599508Z","steps":["trace[1069434634] 'agreement among raft nodes before linearized reading' (duration: 437.779791ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:40.599556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:40.161528Z","time spent":"438.022106ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-30T05:19:40.599592Z","caller":"traceutil/trace.go:171","msg":"trace[291292843] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1364; }","duration":"457.006963ms","start":"2026-05-30T05:19:40.14255Z","end":"2026-05-30T05:19:40.599557Z","steps":["trace[291292843] 'agreement among raft nodes before linearized reading' (duration: 456.49519ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:40.599706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:40.142523Z","time spent":"457.141416ms","remote":"127.0.0.1:36074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-30T05:19:41.182626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.803656ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T05:19:41.182755Z","caller":"traceutil/trace.go:171","msg":"trace[1385074510] transaction","detail":"{read_only:false; response_revision:1365; number_of_response:1; }","duration":"578.357365ms","start":"2026-05-30T05:19:40.604373Z","end":"2026-05-30T05:19:41.182731Z","steps":["trace[1385074510] 'process raft request' (duration: 368.274622ms)","trace[1385074510] 'compare' (duration: 209.51252ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:19:41.182823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:40.604355Z","time spent":"578.436817ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:19:41.241211Z","caller":"traceutil/trace.go:171","msg":"trace[1039703672] linearizableReadLoop","detail":"{readStateIndex:1419; appliedIndex:1417; }","duration":"636.198905ms","start":"2026-05-30T05:19:40.604969Z","end":"2026-05-30T05:19:41.241168Z","steps":["trace[1039703672] 'read index received' (duration: 367.676008ms)","trace[1039703672] 'applied index is now lower than readState.Index' (duration: 268.521117ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:19:41.241627Z","caller":"traceutil/trace.go:171","msg":"trace[1966557266] transaction","detail":"{read_only:false; response_revision:1368; number_of_response:1; }","duration":"635.912118ms","start":"2026-05-30T05:19:40.605688Z","end":"2026-05-30T05:19:41.2416Z","steps":["trace[1966557266] 'process raft request' (duration: 635.419807ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:41.241702Z","caller":"traceutil/trace.go:171","msg":"trace[631582852] transaction","detail":"{read_only:false; response_revision:1366; number_of_response:1; }","duration":"637.012554ms","start":"2026-05-30T05:19:40.604648Z","end":"2026-05-30T05:19:41.241661Z","steps":["trace[631582852] 'process raft request' (duration: 636.182475ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:41.241863Z","caller":"traceutil/trace.go:171","msg":"trace[884670508] transaction","detail":"{read_only:false; response_revision:1367; number_of_response:1; }","duration":"636.147873ms","start":"2026-05-30T05:19:40.605663Z","end":"2026-05-30T05:19:41.241811Z","steps":["trace[884670508] 'process raft request' (duration: 635.384046ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:41.241904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.82649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:19:41.241991Z","caller":"traceutil/trace.go:171","msg":"trace[554669515] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1368; }","duration":"633.946883ms","start":"2026-05-30T05:19:40.608024Z","end":"2026-05-30T05:19:41.241971Z","steps":["trace[554669515] 'agreement among raft nodes before linearized reading' (duration: 633.663416ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:41.241994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.550312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T05:19:41.242044Z","caller":"traceutil/trace.go:171","msg":"trace[1923569296] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1368; }","duration":"366.652944ms","start":"2026-05-30T05:19:40.875379Z","end":"2026-05-30T05:19:41.242032Z","steps":["trace[1923569296] 'agreement among raft nodes before linearized reading' (duration: 366.545572ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:41.242042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.973066ms","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":"warn","ts":"2026-05-30T05:19:41.241929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.350031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-30T05:19:41.242053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:40.608013Z","time spent":"634.020074ms","remote":"127.0.0.1:39748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-30T05:19:41.242096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.098175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:119561"} {"level":"info","ts":"2026-05-30T05:19:41.242159Z","caller":"traceutil/trace.go:171","msg":"trace[734828264] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1368; }","duration":"262.080319ms","start":"2026-05-30T05:19:40.980016Z","end":"2026-05-30T05:19:41.242097Z","steps":["trace[734828264] 'agreement among raft nodes before linearized reading' (duration: 261.840323ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:41.242195Z","caller":"traceutil/trace.go:171","msg":"trace[997757932] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1368; }","duration":"254.662558ms","start":"2026-05-30T05:19:40.987516Z","end":"2026-05-30T05:19:41.242179Z","steps":["trace[997757932] 'agreement among raft nodes before linearized reading' (duration: 254.32372ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:41.242221Z","caller":"traceutil/trace.go:171","msg":"trace[1930265994] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1368; }","duration":"637.255588ms","start":"2026-05-30T05:19:40.604943Z","end":"2026-05-30T05:19:41.242199Z","steps":["trace[1930265994] 'agreement among raft nodes before linearized reading' (duration: 636.89164ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:41.242073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:40.875349Z","time spent":"366.718085ms","remote":"127.0.0.1:55766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":4,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-05-30T05:19:41.242282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:40.604932Z","time spent":"637.339921ms","remote":"127.0.0.1:39828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":119585,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-05-30T05:19:41.241895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:40.604629Z","time spent":"637.163548ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:19:41.24203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:40.605662Z","time spent":"636.02578ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:19:41.242402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:40.605652Z","time spent":"636.307457ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:19:42.659215Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726609342607014,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T05:19:43.087303Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.263980616s","expected-duration":"1s"} {"level":"info","ts":"2026-05-30T05:19:43.087897Z","caller":"traceutil/trace.go:171","msg":"trace[717722659] transaction","detail":"{read_only:false; response_revision:1371; number_of_response:1; }","duration":"1.264712264s","start":"2026-05-30T05:19:41.823156Z","end":"2026-05-30T05:19:43.087868Z","steps":["trace[717722659] 'process raft request' (duration: 1.26455702s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:43.088093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:41.823123Z","time spent":"1.264885887s","remote":"127.0.0.1:39846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T05:19:43.122386Z","caller":"traceutil/trace.go:171","msg":"trace[1453550670] linearizableReadLoop","detail":"{readStateIndex:1425; appliedIndex:1423; }","duration":"964.032707ms","start":"2026-05-30T05:19:42.158322Z","end":"2026-05-30T05:19:43.122355Z","steps":["trace[1453550670] 'read index received' (duration: 929.279358ms)","trace[1453550670] 'applied index is now lower than readState.Index' (duration: 34.751929ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:19:43.122499Z","caller":"traceutil/trace.go:171","msg":"trace[268112749] transaction","detail":"{read_only:false; response_revision:1372; number_of_response:1; }","duration":"517.523275ms","start":"2026-05-30T05:19:42.604925Z","end":"2026-05-30T05:19:43.122449Z","steps":["trace[268112749] 'process raft request' (duration: 517.248739ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:43.122695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"964.350633ms","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-05-30T05:19:43.122744Z","caller":"traceutil/trace.go:171","msg":"trace[2062203517] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1372; }","duration":"964.474796ms","start":"2026-05-30T05:19:42.158253Z","end":"2026-05-30T05:19:43.122727Z","steps":["trace[2062203517] 'agreement among raft nodes before linearized reading' (duration: 964.255921ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:43.122726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:42.604892Z","time spent":"517.708418ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:19:43.122791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:42.158229Z","time spent":"964.550418ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-30T05:19:43.123006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.486155ms","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-05-30T05:19:43.123064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"765.804026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:19:43.123073Z","caller":"traceutil/trace.go:171","msg":"trace[733572211] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1372; }","duration":"331.601318ms","start":"2026-05-30T05:19:42.791451Z","end":"2026-05-30T05:19:43.123053Z","steps":["trace[733572211] 'agreement among raft nodes before linearized reading' (duration: 331.495675ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:43.123107Z","caller":"traceutil/trace.go:171","msg":"trace[983145497] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1372; }","duration":"765.90606ms","start":"2026-05-30T05:19:42.357188Z","end":"2026-05-30T05:19:43.123094Z","steps":["trace[983145497] 'agreement among raft nodes before linearized reading' (duration: 765.831297ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:43.123127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:42.791428Z","time spent":"331.68379ms","remote":"127.0.0.1:38544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-05-30T05:19:43.123144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:42.357153Z","time spent":"765.984262ms","remote":"127.0.0.1:39748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-30T05:19:43.123231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.664318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T05:19:43.123378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.036403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.138\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-30T05:19:43.124328Z","caller":"traceutil/trace.go:171","msg":"trace[1893356459] range","detail":"{range_begin:/registry/masterleases/199.204.45.138; range_end:; response_count:1; response_revision:1372; }","duration":"651.040396ms","start":"2026-05-30T05:19:42.473269Z","end":"2026-05-30T05:19:43.124309Z","steps":["trace[1893356459] 'agreement among raft nodes before linearized reading' (duration: 649.715305ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:43.124583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:42.473199Z","time spent":"651.318623ms","remote":"127.0.0.1:39790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.138\" "} {"level":"info","ts":"2026-05-30T05:19:43.123355Z","caller":"traceutil/trace.go:171","msg":"trace[17923966] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1372; }","duration":"560.984436ms","start":"2026-05-30T05:19:42.562348Z","end":"2026-05-30T05:19:43.123333Z","steps":["trace[17923966] 'agreement among raft nodes before linearized reading' (duration: 560.570106ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:43.124743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:42.562323Z","time spent":"562.369058ms","remote":"127.0.0.1:40036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"warn","ts":"2026-05-30T05:19:43.122718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"789.784939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:19:43.124929Z","caller":"traceutil/trace.go:171","msg":"trace[931018909] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1372; }","duration":"792.03934ms","start":"2026-05-30T05:19:42.332874Z","end":"2026-05-30T05:19:43.124913Z","steps":["trace[931018909] 'agreement among raft nodes before linearized reading' (duration: 789.780238ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:43.124969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:42.332848Z","time spent":"792.106132ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-05-30T05:19:43.683181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.385093ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"warn","ts":"2026-05-30T05:19:43.68345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:43.126158Z","time spent":"557.282599ms","remote":"127.0.0.1:39790","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-30T05:19:43.683586Z","caller":"traceutil/trace.go:171","msg":"trace[1876737803] linearizableReadLoop","detail":"{readStateIndex:1427; appliedIndex:1425; }","duration":"553.36563ms","start":"2026-05-30T05:19:43.130192Z","end":"2026-05-30T05:19:43.683557Z","steps":["trace[1876737803] 'read index received' (duration: 31.614907ms)","trace[1876737803] 'applied index is now lower than readState.Index' (duration: 521.748693ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:19:43.683764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.560164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:19:43.683816Z","caller":"traceutil/trace.go:171","msg":"trace[1882088411] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:1373; }","duration":"553.656756ms","start":"2026-05-30T05:19:43.130143Z","end":"2026-05-30T05:19:43.6838Z","steps":["trace[1882088411] 'agreement among raft nodes before linearized reading' (duration: 553.557074ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:43.683866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:43.130131Z","time spent":"553.719927ms","remote":"127.0.0.1:39854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":29,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-05-30T05:19:43.684033Z","caller":"traceutil/trace.go:171","msg":"trace[1453222114] transaction","detail":"{read_only:false; response_revision:1373; number_of_response:1; }","duration":"555.55949ms","start":"2026-05-30T05:19:43.128134Z","end":"2026-05-30T05:19:43.683694Z","steps":["trace[1453222114] 'process raft request' (duration: 555.222901ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:43.684418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:43.128109Z","time spent":"555.99565ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:19:43.760385Z","caller":"traceutil/trace.go:171","msg":"trace[310051469] transaction","detail":"{read_only:false; response_revision:1374; number_of_response:1; }","duration":"573.002212ms","start":"2026-05-30T05:19:43.187347Z","end":"2026-05-30T05:19:43.76035Z","steps":["trace[310051469] 'process raft request' (duration: 572.840618ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:43.760564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:43.187318Z","time spent":"573.157915ms","remote":"127.0.0.1:39846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T05:19:43.760804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.657223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-30T05:19:43.761165Z","caller":"traceutil/trace.go:171","msg":"trace[588368176] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1374; }","duration":"513.082922ms","start":"2026-05-30T05:19:43.248065Z","end":"2026-05-30T05:19:43.761148Z","steps":["trace[588368176] 'agreement among raft nodes before linearized reading' (duration: 512.523719ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:43.761953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:43.248038Z","time spent":"513.892782ms","remote":"127.0.0.1:40070","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-05-30T05:19:43.760797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.755285ms","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-05-30T05:19:43.762162Z","caller":"traceutil/trace.go:171","msg":"trace[493303196] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1374; }","duration":"574.168648ms","start":"2026-05-30T05:19:43.187955Z","end":"2026-05-30T05:19:43.762124Z","steps":["trace[493303196] 'agreement among raft nodes before linearized reading' (duration: 572.52725ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:43.762335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:43.187944Z","time spent":"574.327072ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-30T05:19:43.760929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.805517ms","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-05-30T05:19:43.762466Z","caller":"traceutil/trace.go:171","msg":"trace[543135572] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1374; }","duration":"514.386753ms","start":"2026-05-30T05:19:43.248057Z","end":"2026-05-30T05:19:43.762444Z","steps":["trace[543135572] 'agreement among raft nodes before linearized reading' (duration: 512.583152ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:43.762534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:43.247995Z","time spent":"514.520136ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-30T05:19:43.761272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.100573ms","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-05-30T05:19:43.762647Z","caller":"traceutil/trace.go:171","msg":"trace[811943827] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1374; }","duration":"514.541427ms","start":"2026-05-30T05:19:43.248096Z","end":"2026-05-30T05:19:43.762637Z","steps":["trace[811943827] 'agreement among raft nodes before linearized reading' (duration: 512.405827ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:43.762684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:43.248077Z","time spent":"514.597898ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-30T05:19:43.98418Z","caller":"traceutil/trace.go:171","msg":"trace[351209718] transaction","detail":"{read_only:false; response_revision:1376; number_of_response:1; }","duration":"297.533584ms","start":"2026-05-30T05:19:43.686618Z","end":"2026-05-30T05:19:43.984151Z","steps":["trace[351209718] 'process raft request' (duration: 297.475963ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:43.984457Z","caller":"traceutil/trace.go:171","msg":"trace[774382062] transaction","detail":"{read_only:false; response_revision:1375; number_of_response:1; }","duration":"299.790826ms","start":"2026-05-30T05:19:43.68463Z","end":"2026-05-30T05:19:43.984421Z","steps":["trace[774382062] 'process raft request' (duration: 299.247164ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:44.490201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.55339ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-30T05:19:44.490578Z","caller":"traceutil/trace.go:171","msg":"trace[1023134690] transaction","detail":"{read_only:false; response_revision:1377; number_of_response:1; }","duration":"724.544217ms","start":"2026-05-30T05:19:43.76599Z","end":"2026-05-30T05:19:44.490534Z","steps":["trace[1023134690] 'process raft request' (duration: 607.547106ms)","trace[1023134690] 'compare' (duration: 116.348225ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:19:44.490691Z","caller":"traceutil/trace.go:171","msg":"trace[319947805] linearizableReadLoop","detail":"{readStateIndex:1435; appliedIndex:1430; }","duration":"503.517443ms","start":"2026-05-30T05:19:43.987154Z","end":"2026-05-30T05:19:44.490672Z","steps":["trace[319947805] 'read index received' (duration: 386.387939ms)","trace[319947805] 'applied index is now lower than readState.Index' (duration: 117.128034ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:19:44.490726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:43.765964Z","time spent":"724.692661ms","remote":"127.0.0.1:39846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":837,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T05:19:44.490963Z","caller":"traceutil/trace.go:171","msg":"trace[608141434] transaction","detail":"{read_only:false; response_revision:1381; number_of_response:1; }","duration":"723.289728ms","start":"2026-05-30T05:19:43.76763Z","end":"2026-05-30T05:19:44.49092Z","steps":["trace[608141434] 'process raft request' (duration: 722.984711ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:44.490978Z","caller":"traceutil/trace.go:171","msg":"trace[2027504902] transaction","detail":"{read_only:false; response_revision:1378; number_of_response:1; }","duration":"724.930966ms","start":"2026-05-30T05:19:43.766013Z","end":"2026-05-30T05:19:44.490944Z","steps":["trace[2027504902] 'process raft request' (duration: 724.334883ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:44.49109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.864921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-05-30T05:19:44.491142Z","caller":"traceutil/trace.go:171","msg":"trace[1091080905] transaction","detail":"{read_only:false; response_revision:1379; number_of_response:1; }","duration":"724.271011ms","start":"2026-05-30T05:19:43.766853Z","end":"2026-05-30T05:19:44.491124Z","steps":["trace[1091080905] 'process raft request' (duration: 723.606186ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:44.491165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:43.76598Z","time spent":"725.083839ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:19:44.49117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:43.767607Z","time spent":"723.444172ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:19:44.491181Z","caller":"traceutil/trace.go:171","msg":"trace[1715450435] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1381; }","duration":"504.051195ms","start":"2026-05-30T05:19:43.987105Z","end":"2026-05-30T05:19:44.491156Z","steps":["trace[1715450435] 'agreement among raft nodes before linearized reading' (duration: 503.81424ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:44.491317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:43.98708Z","time spent":"504.22361ms","remote":"127.0.0.1:39946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":446,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-05-30T05:19:44.491317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:43.766842Z","time spent":"724.360123ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:19:44.49138Z","caller":"traceutil/trace.go:171","msg":"trace[713699302] transaction","detail":"{read_only:false; response_revision:1380; number_of_response:1; }","duration":"723.364459ms","start":"2026-05-30T05:19:43.767537Z","end":"2026-05-30T05:19:44.490901Z","steps":["trace[713699302] 'process raft request' (duration: 723.019022ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:44.491846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:43.767528Z","time spent":"724.28177ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:19:44.519102Z","caller":"traceutil/trace.go:171","msg":"trace[375358247] transaction","detail":"{read_only:false; response_revision:1382; number_of_response:1; }","duration":"525.612431ms","start":"2026-05-30T05:19:43.993458Z","end":"2026-05-30T05:19:44.51907Z","steps":["trace[375358247] 'process raft request' (duration: 525.438257ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:44.519271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:43.993395Z","time spent":"525.779616ms","remote":"127.0.0.1:39846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":929,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T05:19:44.519583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.33789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"warn","ts":"2026-05-30T05:19:44.520121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.480128ms","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-05-30T05:19:44.520196Z","caller":"traceutil/trace.go:171","msg":"trace[311986334] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1382; }","duration":"272.732893ms","start":"2026-05-30T05:19:44.247445Z","end":"2026-05-30T05:19:44.520178Z","steps":["trace[311986334] 'agreement among raft nodes before linearized reading' (duration: 272.358925ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:44.519769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.373941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:19:44.520295Z","caller":"traceutil/trace.go:171","msg":"trace[916724680] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1382; }","duration":"165.002056ms","start":"2026-05-30T05:19:44.35528Z","end":"2026-05-30T05:19:44.520282Z","steps":["trace[916724680] 'agreement among raft nodes before linearized reading' (duration: 164.428923ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:44.520143Z","caller":"traceutil/trace.go:171","msg":"trace[1584700446] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1382; }","duration":"530.937263ms","start":"2026-05-30T05:19:43.989183Z","end":"2026-05-30T05:19:44.52012Z","steps":["trace[1584700446] 'agreement among raft nodes before linearized reading' (duration: 529.90505ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:44.521059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:43.989172Z","time spent":"531.868225ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":559,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-05-30T05:19:46.453194Z","caller":"traceutil/trace.go:171","msg":"trace[1008962836] linearizableReadLoop","detail":"{readStateIndex:1445; appliedIndex:1443; }","duration":"111.214087ms","start":"2026-05-30T05:19:46.341951Z","end":"2026-05-30T05:19:46.453165Z","steps":["trace[1008962836] 'read index received' (duration: 10.262805ms)","trace[1008962836] 'applied index is now lower than readState.Index' (duration: 100.949562ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:19:46.453233Z","caller":"traceutil/trace.go:171","msg":"trace[1440576609] transaction","detail":"{read_only:false; response_revision:1391; number_of_response:1; }","duration":"112.332274ms","start":"2026-05-30T05:19:46.340869Z","end":"2026-05-30T05:19:46.453201Z","steps":["trace[1440576609] 'process raft request' (duration: 112.139429ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:46.453419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.450533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:19:46.453468Z","caller":"traceutil/trace.go:171","msg":"trace[1045170163] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1391; }","duration":"111.554586ms","start":"2026-05-30T05:19:46.341899Z","end":"2026-05-30T05:19:46.453454Z","steps":["trace[1045170163] 'agreement among raft nodes before linearized reading' (duration: 111.433193ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:47.700387Z","caller":"traceutil/trace.go:171","msg":"trace[1682803934] linearizableReadLoop","detail":"{readStateIndex:1461; appliedIndex:1460; }","duration":"493.102883ms","start":"2026-05-30T05:19:47.207261Z","end":"2026-05-30T05:19:47.700364Z","steps":["trace[1682803934] 'read index received' (duration: 492.95306ms)","trace[1682803934] 'applied index is now lower than readState.Index' (duration: 148.593µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:19:47.700561Z","caller":"traceutil/trace.go:171","msg":"trace[625243761] transaction","detail":"{read_only:false; response_revision:1407; number_of_response:1; }","duration":"561.456815ms","start":"2026-05-30T05:19:47.139008Z","end":"2026-05-30T05:19:47.700465Z","steps":["trace[625243761] 'process raft request' (duration: 561.196049ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:47.700628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.376821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-nkhz9\" ","response":"range_response_count:1 size:12642"} {"level":"info","ts":"2026-05-30T05:19:47.700873Z","caller":"traceutil/trace.go:171","msg":"trace[1403839388] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-nkhz9; range_end:; response_count:1; response_revision:1407; }","duration":"493.678787ms","start":"2026-05-30T05:19:47.207179Z","end":"2026-05-30T05:19:47.700858Z","steps":["trace[1403839388] 'agreement among raft nodes before linearized reading' (duration: 493.293107ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:47.700914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:47.207154Z","time spent":"493.748149ms","remote":"127.0.0.1:39972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":12666,"request content":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-nkhz9\" "} {"level":"warn","ts":"2026-05-30T05:19:47.700892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:47.138964Z","time spent":"561.795373ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:19:48.675582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"773.338599ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-30T05:19:48.676038Z","caller":"traceutil/trace.go:171","msg":"trace[1629192631] linearizableReadLoop","detail":"{readStateIndex:1462; appliedIndex:1461; }","duration":"968.347704ms","start":"2026-05-30T05:19:47.707658Z","end":"2026-05-30T05:19:48.676005Z","steps":["trace[1629192631] 'read index received' (duration: 194.634607ms)","trace[1629192631] 'applied index is now lower than readState.Index' (duration: 773.709787ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:19:48.676348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"968.680832ms","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-05-30T05:19:48.676443Z","caller":"traceutil/trace.go:171","msg":"trace[452674368] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1407; }","duration":"968.781205ms","start":"2026-05-30T05:19:47.70764Z","end":"2026-05-30T05:19:48.676421Z","steps":["trace[452674368] 'agreement among raft nodes before linearized reading' (duration: 968.478458ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:48.676752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:47.707573Z","time spent":"969.008169ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-30T05:19:48.676886Z","caller":"traceutil/trace.go:171","msg":"trace[1310627247] transaction","detail":"{read_only:false; response_revision:1408; number_of_response:1; }","duration":"961.546448ms","start":"2026-05-30T05:19:47.715316Z","end":"2026-05-30T05:19:48.676863Z","steps":["trace[1310627247] 'process raft request' (duration: 960.479283ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:48.677036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:47.715289Z","time spent":"961.65077ms","remote":"127.0.0.1:39972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13709,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:19:48.682178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.036579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:19:48.682278Z","caller":"traceutil/trace.go:171","msg":"trace[1930647452] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1409; }","duration":"326.181553ms","start":"2026-05-30T05:19:48.35607Z","end":"2026-05-30T05:19:48.682251Z","steps":["trace[1930647452] 'agreement among raft nodes before linearized reading' (duration: 326.036189ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:48.68251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:48.356041Z","time spent":"326.449269ms","remote":"127.0.0.1:39748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-30T05:19:48.683129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.79736ms","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-05-30T05:19:48.68322Z","caller":"traceutil/trace.go:171","msg":"trace[1000056736] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1409; }","duration":"135.182789ms","start":"2026-05-30T05:19:48.548014Z","end":"2026-05-30T05:19:48.683197Z","steps":["trace[1000056736] 'agreement among raft nodes before linearized reading' (duration: 134.468563ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:48.683584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.99248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-30T05:19:48.683179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.297861ms","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-05-30T05:19:48.683593Z","caller":"traceutil/trace.go:171","msg":"trace[910686709] transaction","detail":"{read_only:false; response_revision:1409; number_of_response:1; }","duration":"763.43899ms","start":"2026-05-30T05:19:47.920118Z","end":"2026-05-30T05:19:48.683557Z","steps":["trace[910686709] 'process raft request' (duration: 761.856924ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:48.683645Z","caller":"traceutil/trace.go:171","msg":"trace[684771993] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1409; }","duration":"137.133524ms","start":"2026-05-30T05:19:48.546501Z","end":"2026-05-30T05:19:48.683635Z","steps":["trace[684771993] 'agreement among raft nodes before linearized reading' (duration: 136.571141ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:48.683658Z","caller":"traceutil/trace.go:171","msg":"trace[621601373] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1409; }","duration":"135.842514ms","start":"2026-05-30T05:19:48.547801Z","end":"2026-05-30T05:19:48.683644Z","steps":["trace[621601373] 'agreement among raft nodes before linearized reading' (duration: 135.132708ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:48.68381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.203132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-30T05:19:48.683812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:47.920086Z","time spent":"763.580384ms","remote":"127.0.0.1:40070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:19:48.683848Z","caller":"traceutil/trace.go:171","msg":"trace[2145226549] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1409; }","duration":"136.316236ms","start":"2026-05-30T05:19:48.54752Z","end":"2026-05-30T05:19:48.683837Z","steps":["trace[2145226549] 'agreement among raft nodes before linearized reading' (duration: 136.204732ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:58.874765Z","caller":"traceutil/trace.go:171","msg":"trace[620645839] transaction","detail":"{read_only:false; response_revision:1460; number_of_response:1; }","duration":"102.191157ms","start":"2026-05-30T05:19:58.772545Z","end":"2026-05-30T05:19:58.874737Z","steps":["trace[620645839] 'process raft request' (duration: 101.991613ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:59.676715Z","caller":"traceutil/trace.go:171","msg":"trace[833838747] transaction","detail":"{read_only:false; response_revision:1468; number_of_response:1; }","duration":"114.070803ms","start":"2026-05-30T05:19:59.562612Z","end":"2026-05-30T05:19:59.676682Z","steps":["trace[833838747] 'process raft request' (duration: 76.575507ms)","trace[833838747] 'compare' (duration: 37.327102ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:20:03.041272Z","caller":"traceutil/trace.go:171","msg":"trace[1802487705] transaction","detail":"{read_only:false; response_revision:1481; number_of_response:1; }","duration":"112.619489ms","start":"2026-05-30T05:20:02.928624Z","end":"2026-05-30T05:20:03.041243Z","steps":["trace[1802487705] 'process raft request' (duration: 56.73924ms)","trace[1802487705] 'compare' (duration: 55.469619ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:20:03.211353Z","caller":"traceutil/trace.go:171","msg":"trace[1726464048] transaction","detail":"{read_only:false; response_revision:1483; number_of_response:1; }","duration":"165.137271ms","start":"2026-05-30T05:20:03.046173Z","end":"2026-05-30T05:20:03.21131Z","steps":["trace[1726464048] 'process raft request' (duration: 122.097318ms)","trace[1726464048] 'compare' (duration: 42.694855ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:20:03.211426Z","caller":"traceutil/trace.go:171","msg":"trace[1585938246] transaction","detail":"{read_only:false; response_revision:1485; number_of_response:1; }","duration":"161.580367ms","start":"2026-05-30T05:20:03.049813Z","end":"2026-05-30T05:20:03.211393Z","steps":["trace[1585938246] 'process raft request' (duration: 161.515776ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:03.211652Z","caller":"traceutil/trace.go:171","msg":"trace[306728574] transaction","detail":"{read_only:false; response_revision:1484; number_of_response:1; }","duration":"163.593174ms","start":"2026-05-30T05:20:03.048Z","end":"2026-05-30T05:20:03.211593Z","steps":["trace[306728574] 'process raft request' (duration: 163.188385ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:07.269641Z","caller":"traceutil/trace.go:171","msg":"trace[501027275] transaction","detail":"{read_only:false; response_revision:1500; number_of_response:1; }","duration":"140.806049ms","start":"2026-05-30T05:20:07.128803Z","end":"2026-05-30T05:20:07.269609Z","steps":["trace[501027275] 'process raft request' (duration: 140.639495ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:07.306373Z","caller":"traceutil/trace.go:171","msg":"trace[1945043448] transaction","detail":"{read_only:false; response_revision:1501; number_of_response:1; }","duration":"176.986693ms","start":"2026-05-30T05:20:07.12934Z","end":"2026-05-30T05:20:07.306327Z","steps":["trace[1945043448] 'process raft request' (duration: 176.712977ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:11.525706Z","caller":"traceutil/trace.go:171","msg":"trace[1336006714] transaction","detail":"{read_only:false; response_revision:1520; number_of_response:1; }","duration":"124.562954ms","start":"2026-05-30T05:20:11.4011Z","end":"2026-05-30T05:20:11.525663Z","steps":["trace[1336006714] 'process raft request' (duration: 124.451161ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:11.525749Z","caller":"traceutil/trace.go:171","msg":"trace[1893591063] transaction","detail":"{read_only:false; response_revision:1519; number_of_response:1; }","duration":"124.707086ms","start":"2026-05-30T05:20:11.400983Z","end":"2026-05-30T05:20:11.52569Z","steps":["trace[1893591063] 'process raft request' (duration: 88.762607ms)","trace[1893591063] 'compare' (duration: 35.640242ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:20:11.526041Z","caller":"traceutil/trace.go:171","msg":"trace[819626953] transaction","detail":"{read_only:false; response_revision:1521; number_of_response:1; }","duration":"124.873431ms","start":"2026-05-30T05:20:11.401143Z","end":"2026-05-30T05:20:11.526016Z","steps":["trace[819626953] 'process raft request' (duration: 124.466382ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:33.797593Z","caller":"traceutil/trace.go:171","msg":"trace[974361098] transaction","detail":"{read_only:false; response_revision:1622; number_of_response:1; }","duration":"104.117963ms","start":"2026-05-30T05:20:33.693445Z","end":"2026-05-30T05:20:33.797563Z","steps":["trace[974361098] 'process raft request' (duration: 99.25991ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:21:03.836689Z","caller":"traceutil/trace.go:171","msg":"trace[1282114733] transaction","detail":"{read_only:false; response_revision:1758; number_of_response:1; }","duration":"120.149666ms","start":"2026-05-30T05:21:03.716507Z","end":"2026-05-30T05:21:03.836656Z","steps":["trace[1282114733] 'process raft request' (duration: 119.810858ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:21:42.611633Z","caller":"traceutil/trace.go:171","msg":"trace[1482972920] transaction","detail":"{read_only:false; response_revision:1941; number_of_response:1; }","duration":"112.996531ms","start":"2026-05-30T05:21:42.498568Z","end":"2026-05-30T05:21:42.611565Z","steps":["trace[1482972920] 'process raft request' (duration: 69.305183ms)","trace[1482972920] 'compare' (duration: 43.390312ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:22:42.852944Z","caller":"traceutil/trace.go:171","msg":"trace[19517765] transaction","detail":"{read_only:false; response_revision:2217; number_of_response:1; }","duration":"115.427705ms","start":"2026-05-30T05:22:42.737494Z","end":"2026-05-30T05:22:42.852921Z","steps":["trace[19517765] 'process raft request' (duration: 115.282132ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:23:13.281005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.639699ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T05:23:13.281269Z","caller":"traceutil/trace.go:171","msg":"trace[1152765701] transaction","detail":"{read_only:false; response_revision:2354; number_of_response:1; }","duration":"246.936553ms","start":"2026-05-30T05:23:13.034287Z","end":"2026-05-30T05:23:13.281224Z","steps":["trace[1152765701] 'process raft request' (duration: 59.954296ms)","trace[1152765701] 'compare' (duration: 186.432465ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:23:13.281301Z","caller":"traceutil/trace.go:171","msg":"trace[1801494226] transaction","detail":"{read_only:false; response_revision:2355; number_of_response:1; }","duration":"245.677095ms","start":"2026-05-30T05:23:13.03559Z","end":"2026-05-30T05:23:13.281267Z","steps":["trace[1801494226] 'process raft request' (duration: 245.557812ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:23:57.157674Z","caller":"traceutil/trace.go:171","msg":"trace[352723968] transaction","detail":"{read_only:false; response_revision:2578; number_of_response:1; }","duration":"171.354312ms","start":"2026-05-30T05:23:56.986292Z","end":"2026-05-30T05:23:57.157647Z","steps":["trace[352723968] 'process raft request' (duration: 171.176628ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:23:57.173191Z","caller":"traceutil/trace.go:171","msg":"trace[1193715824] linearizableReadLoop","detail":"{readStateIndex:2684; appliedIndex:2682; }","duration":"141.04724ms","start":"2026-05-30T05:23:57.032119Z","end":"2026-05-30T05:23:57.173166Z","steps":["trace[1193715824] 'read index received' (duration: 125.376604ms)","trace[1193715824] 'applied index is now lower than readState.Index' (duration: 15.669346ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:23:57.173326Z","caller":"traceutil/trace.go:171","msg":"trace[1539784404] transaction","detail":"{read_only:false; response_revision:2579; number_of_response:1; }","duration":"185.534224ms","start":"2026-05-30T05:23:56.987781Z","end":"2026-05-30T05:23:57.173315Z","steps":["trace[1539784404] 'process raft request' (duration: 185.240128ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:23:57.174147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.011612ms","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:508"} {"level":"info","ts":"2026-05-30T05:23:57.174222Z","caller":"traceutil/trace.go:171","msg":"trace[1552902749] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2579; }","duration":"142.142435ms","start":"2026-05-30T05:23:57.03206Z","end":"2026-05-30T05:23:57.174202Z","steps":["trace[1552902749] 'agreement among raft nodes before linearized reading' (duration: 141.976261ms)"],"step_count":1}