{"level":"warn","ts":"2026-05-07T20:54:15.512934Z","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-07T20:54:15.513019Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.223:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.223:2380","--initial-cluster=instance=https://199.204.45.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.223:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-07T20:54:15.513083Z","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-07T20:54:15.513095Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-05-07T20:54:15.513113Z","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-07T20:54:15.513681Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"]} {"level":"info","ts":"2026-05-07T20:54:15.513753Z","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.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.223:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-07T20:54:15.51858Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.633078ms"} {"level":"info","ts":"2026-05-07T20:54:15.52819Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"11f26225a5bb9fe3","cluster-id":"75c25101f01fd4c6"} {"level":"info","ts":"2026-05-07T20:54:15.52827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=()"} {"level":"info","ts":"2026-05-07T20:54:15.528293Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 0"} {"level":"info","ts":"2026-05-07T20:54:15.528307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 11f26225a5bb9fe3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-07T20:54:15.528317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 1"} {"level":"info","ts":"2026-05-07T20:54:15.528363Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"warn","ts":"2026-05-07T20:54:15.534778Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-07T20:54:15.537704Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-07T20:54:15.540898Z","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-07T20:54:15.543454Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"11f26225a5bb9fe3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-07T20:54:15.543995Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"11f26225a5bb9fe3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-07T20:54:15.54411Z","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-07T20:54:15.544139Z","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-07T20:54:15.544148Z","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-07T20:54:15.545405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"info","ts":"2026-05-07T20:54:15.545664Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","added-peer-id":"11f26225a5bb9fe3","added-peer-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-05-07T20:54:15.548421Z","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-07T20:54:15.548657Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"11f26225a5bb9fe3","initial-advertise-peer-urls":["https://199.204.45.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-07T20:54:15.548687Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-07T20:54:15.548843Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-05-07T20:54:15.548913Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-05-07T20:54:15.629088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 is starting a new election at term 1"} {"level":"info","ts":"2026-05-07T20:54:15.629144Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-07T20:54:15.629175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgPreVoteResp from 11f26225a5bb9fe3 at term 1"} {"level":"info","ts":"2026-05-07T20:54:15.62919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became candidate at term 2"} {"level":"info","ts":"2026-05-07T20:54:15.629198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgVoteResp from 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-05-07T20:54:15.62921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became leader at term 2"} {"level":"info","ts":"2026-05-07T20:54:15.629221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 11f26225a5bb9fe3 elected leader 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-05-07T20:54:15.630113Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T20:54:15.630935Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-07T20:54:15.630936Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"11f26225a5bb9fe3","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.223:2379]}","request-path":"/0/members/11f26225a5bb9fe3/attributes","cluster-id":"75c25101f01fd4c6","publish-timeout":"7s"} {"level":"info","ts":"2026-05-07T20:54:15.631301Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T20:54:15.631338Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-07T20:54:15.63142Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T20:54:15.631477Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T20:54:15.63165Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-07T20:54:15.631729Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-07T20:54:15.634574Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.223:2379"} {"level":"info","ts":"2026-05-07T20:54:15.634574Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-07T20:54:19.228038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.918066ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-07T20:54:19.228161Z","caller":"traceutil/trace.go:171","msg":"trace[1009383567] transaction","detail":"{read_only:false; response_revision:145; number_of_response:1; }","duration":"693.587528ms","start":"2026-05-07T20:54:18.534556Z","end":"2026-05-07T20:54:19.228144Z","steps":["trace[1009383567] 'process raft request' (duration: 48.137619ms)","trace[1009383567] 'compare' (duration: 644.789392ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T20:54:19.22824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:18.534546Z","time spent":"693.67232ms","remote":"127.0.0.1:41628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":659,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T20:54:20.541099Z","caller":"traceutil/trace.go:171","msg":"trace[473359272] transaction","detail":"{read_only:false; response_revision:208; number_of_response:1; }","duration":"169.757683ms","start":"2026-05-07T20:54:20.371328Z","end":"2026-05-07T20:54:20.541086Z","steps":["trace[473359272] 'process raft request' (duration: 169.567547ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:20.541069Z","caller":"traceutil/trace.go:171","msg":"trace[1135968168] linearizableReadLoop","detail":"{readStateIndex:213; appliedIndex:212; }","duration":"111.031074ms","start":"2026-05-07T20:54:20.430015Z","end":"2026-05-07T20:54:20.541047Z","steps":["trace[1135968168] 'read index received' (duration: 110.790957ms)","trace[1135968168] 'applied index is now lower than readState.Index' (duration: 239.377µs)"],"step_count":2} {"level":"warn","ts":"2026-05-07T20:54:20.541355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.322151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T20:54:20.541421Z","caller":"traceutil/trace.go:171","msg":"trace[101268681] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:208; }","duration":"111.451565ms","start":"2026-05-07T20:54:20.429951Z","end":"2026-05-07T20:54:20.541403Z","steps":["trace[101268681] 'agreement among raft nodes before linearized reading' (duration: 111.191038ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:24.075236Z","caller":"traceutil/trace.go:171","msg":"trace[769390757] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"123.791608ms","start":"2026-05-07T20:54:23.951406Z","end":"2026-05-07T20:54:24.075198Z","steps":["trace[769390757] 'process raft request' (duration: 123.51651ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:26.17086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.807109ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-07T20:54:26.171055Z","caller":"traceutil/trace.go:171","msg":"trace[1494513854] linearizableReadLoop","detail":"{readStateIndex:382; appliedIndex:381; }","duration":"420.38772ms","start":"2026-05-07T20:54:25.750647Z","end":"2026-05-07T20:54:26.171035Z","steps":["trace[1494513854] 'read index received' (duration: 130.347106ms)","trace[1494513854] 'applied index is now lower than readState.Index' (duration: 290.039224ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T20:54:26.171058Z","caller":"traceutil/trace.go:171","msg":"trace[756571712] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"463.447732ms","start":"2026-05-07T20:54:25.707586Z","end":"2026-05-07T20:54:26.171034Z","steps":["trace[756571712] 'process raft request' (duration: 173.391897ms)","trace[756571712] 'compare' (duration: 289.660115ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T20:54:26.17119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.536355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-05-07T20:54:26.171227Z","caller":"traceutil/trace.go:171","msg":"trace[45789496] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:370; }","duration":"420.611176ms","start":"2026-05-07T20:54:25.750606Z","end":"2026-05-07T20:54:26.171218Z","steps":["trace[45789496] 'agreement among raft nodes before linearized reading' (duration: 420.507093ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:26.171251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:25.750593Z","time spent":"420.652128ms","remote":"127.0.0.1:41490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "} {"level":"warn","ts":"2026-05-07T20:54:26.171325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:25.707576Z","time spent":"463.686329ms","remote":"127.0.0.1:41556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1050,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-07T20:54:26.171479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.335669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-05-07T20:54:26.171507Z","caller":"traceutil/trace.go:171","msg":"trace[1381247064] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:370; }","duration":"320.41593ms","start":"2026-05-07T20:54:25.851084Z","end":"2026-05-07T20:54:26.1715Z","steps":["trace[1381247064] 'agreement among raft nodes before linearized reading' (duration: 320.371629ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:26.171526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:25.851061Z","time spent":"320.461102ms","remote":"127.0.0.1:41490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":240,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "} {"level":"warn","ts":"2026-05-07T20:54:26.171538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.526647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-07T20:54:26.171645Z","caller":"traceutil/trace.go:171","msg":"trace[1066045259] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:370; }","duration":"370.66677ms","start":"2026-05-07T20:54:25.800947Z","end":"2026-05-07T20:54:26.171614Z","steps":["trace[1066045259] 'agreement among raft nodes before linearized reading' (duration: 370.430114ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:26.171699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:25.800934Z","time spent":"370.754973ms","remote":"127.0.0.1:41490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"warn","ts":"2026-05-07T20:54:26.171973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.769531ms","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-07T20:54:26.172227Z","caller":"traceutil/trace.go:171","msg":"trace[969175779] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:370; }","duration":"332.995367ms","start":"2026-05-07T20:54:25.839093Z","end":"2026-05-07T20:54:26.172089Z","steps":["trace[969175779] 'agreement among raft nodes before linearized reading' (duration: 332.747371ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:26.172446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:25.839042Z","time spent":"333.280543ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-07T20:54:26.670863Z","caller":"traceutil/trace.go:171","msg":"trace[1864630656] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"494.647017ms","start":"2026-05-07T20:54:26.176106Z","end":"2026-05-07T20:54:26.670753Z","steps":["trace[1864630656] 'process raft request' (duration: 446.883352ms)","trace[1864630656] 'compare' (duration: 47.009535ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T20:54:26.671002Z","caller":"traceutil/trace.go:171","msg":"trace[407088328] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"492.288126ms","start":"2026-05-07T20:54:26.178684Z","end":"2026-05-07T20:54:26.670973Z","steps":["trace[407088328] 'process raft request' (duration: 491.990759ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:26.671127Z","caller":"traceutil/trace.go:171","msg":"trace[1614299300] linearizableReadLoop","detail":"{readStateIndex:387; appliedIndex:383; }","duration":"100.644393ms","start":"2026-05-07T20:54:26.570465Z","end":"2026-05-07T20:54:26.67111Z","steps":["trace[1614299300] 'read index received' (duration: 52.549429ms)","trace[1614299300] 'applied index is now lower than readState.Index' (duration: 48.094074ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T20:54:26.67116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:26.178676Z","time spent":"492.41425ms","remote":"127.0.0.1:41490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":156,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T20:54:26.671207Z","caller":"traceutil/trace.go:171","msg":"trace[1010840094] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"491.555407ms","start":"2026-05-07T20:54:26.179613Z","end":"2026-05-07T20:54:26.671169Z","steps":["trace[1010840094] 'process raft request' (duration: 491.450004ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:26.671242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:26.176097Z","time spent":"494.857242ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T20:54:26.671344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:26.179555Z","time spent":"491.727422ms","remote":"127.0.0.1:41464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3527,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-07T20:54:26.671342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.86606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-proxy-q5whv.18ad63e570606f0b\" ","response":"range_response_count:1 size:769"} {"level":"info","ts":"2026-05-07T20:54:26.67142Z","caller":"traceutil/trace.go:171","msg":"trace[283992153] range","detail":"{range_begin:/registry/events/kube-system/kube-proxy-q5whv.18ad63e570606f0b; range_end:; response_count:1; response_revision:375; }","duration":"100.985433ms","start":"2026-05-07T20:54:26.570415Z","end":"2026-05-07T20:54:26.671401Z","steps":["trace[283992153] 'agreement among raft nodes before linearized reading' (duration: 100.792938ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:26.671544Z","caller":"traceutil/trace.go:171","msg":"trace[1882141640] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"492.831681ms","start":"2026-05-07T20:54:26.178693Z","end":"2026-05-07T20:54:26.671525Z","steps":["trace[1882141640] 'process raft request' (duration: 492.120022ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:26.67167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:26.178674Z","time spent":"492.948823ms","remote":"127.0.0.1:41382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1723,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T20:54:45.701169Z","caller":"traceutil/trace.go:171","msg":"trace[951201288] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"123.881155ms","start":"2026-05-07T20:54:45.577262Z","end":"2026-05-07T20:54:45.701144Z","steps":["trace[951201288] 'process raft request' (duration: 123.68926ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:45.712105Z","caller":"traceutil/trace.go:171","msg":"trace[1328717719] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"132.490798ms","start":"2026-05-07T20:54:45.579598Z","end":"2026-05-07T20:54:45.712089Z","steps":["trace[1328717719] 'process raft request' (duration: 131.746399ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:45.71234Z","caller":"traceutil/trace.go:171","msg":"trace[1966725988] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"120.375694ms","start":"2026-05-07T20:54:45.591914Z","end":"2026-05-07T20:54:45.71229Z","steps":["trace[1966725988] 'process raft request' (duration: 119.683126ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:45.712355Z","caller":"traceutil/trace.go:171","msg":"trace[1485941306] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"132.637452ms","start":"2026-05-07T20:54:45.57968Z","end":"2026-05-07T20:54:45.712318Z","steps":["trace[1485941306] 'process raft request' (duration: 131.753319ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:45.712429Z","caller":"traceutil/trace.go:171","msg":"trace[1979640563] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"107.581583ms","start":"2026-05-07T20:54:45.604842Z","end":"2026-05-07T20:54:45.712423Z","steps":["trace[1979640563] 'process raft request' (duration: 106.860054ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:45.712289Z","caller":"traceutil/trace.go:171","msg":"trace[728361111] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"127.585051ms","start":"2026-05-07T20:54:45.584689Z","end":"2026-05-07T20:54:45.712274Z","steps":["trace[728361111] 'process raft request' (duration: 126.797791ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:45.712362Z","caller":"traceutil/trace.go:171","msg":"trace[1867890313] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"106.154377ms","start":"2026-05-07T20:54:45.606183Z","end":"2026-05-07T20:54:45.712338Z","steps":["trace[1867890313] 'process raft request' (duration: 105.605713ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:45.712408Z","caller":"traceutil/trace.go:171","msg":"trace[2098528074] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"115.838198ms","start":"2026-05-07T20:54:45.596564Z","end":"2026-05-07T20:54:45.712402Z","steps":["trace[2098528074] 'process raft request' (duration: 115.096028ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:45.712654Z","caller":"traceutil/trace.go:171","msg":"trace[398581495] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"124.933792ms","start":"2026-05-07T20:54:45.587628Z","end":"2026-05-07T20:54:45.712562Z","steps":["trace[398581495] 'process raft request' (duration: 123.936677ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:45.712705Z","caller":"traceutil/trace.go:171","msg":"trace[630982759] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"125.581428ms","start":"2026-05-07T20:54:45.587104Z","end":"2026-05-07T20:54:45.712685Z","steps":["trace[630982759] 'process raft request' (duration: 124.427069ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:46.025566Z","caller":"traceutil/trace.go:171","msg":"trace[1539221390] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"290.525916ms","start":"2026-05-07T20:54:45.735014Z","end":"2026-05-07T20:54:46.02554Z","steps":["trace[1539221390] 'process raft request' (duration: 290.473885ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:46.025589Z","caller":"traceutil/trace.go:171","msg":"trace[1324310428] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"294.623733ms","start":"2026-05-07T20:54:45.730934Z","end":"2026-05-07T20:54:46.025558Z","steps":["trace[1324310428] 'process raft request' (duration: 293.672908ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:46.039318Z","caller":"traceutil/trace.go:171","msg":"trace[373452822] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"300.799163ms","start":"2026-05-07T20:54:45.738488Z","end":"2026-05-07T20:54:46.039287Z","steps":["trace[373452822] 'process raft request' (duration: 300.511475ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:46.039701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:45.738465Z","time spent":"301.154931ms","remote":"127.0.0.1:41330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T20:54:46.042071Z","caller":"traceutil/trace.go:171","msg":"trace[231605224] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"303.280957ms","start":"2026-05-07T20:54:45.738773Z","end":"2026-05-07T20:54:46.042054Z","steps":["trace[231605224] 'process raft request' (duration: 300.811572ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:46.042338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:45.738763Z","time spent":"303.335489ms","remote":"127.0.0.1:41330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T20:54:46.042355Z","caller":"traceutil/trace.go:171","msg":"trace[58356916] transaction","detail":"{read_only:false; number_of_response:0; response_revision:533; }","duration":"301.436879ms","start":"2026-05-07T20:54:45.740896Z","end":"2026-05-07T20:54:46.042333Z","steps":["trace[58356916] 'process raft request' (duration: 301.139421ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:46.042468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:45.740887Z","time spent":"301.51945ms","remote":"127.0.0.1:41800","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T20:54:46.042875Z","caller":"traceutil/trace.go:171","msg":"trace[442137059] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"297.595749ms","start":"2026-05-07T20:54:45.745253Z","end":"2026-05-07T20:54:46.042849Z","steps":["trace[442137059] 'process raft request' (duration: 296.935682ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:46.043104Z","caller":"traceutil/trace.go:171","msg":"trace[719764127] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"297.795594ms","start":"2026-05-07T20:54:45.745297Z","end":"2026-05-07T20:54:46.043092Z","steps":["trace[719764127] 'process raft request' (duration: 297.134967ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:46.043373Z","caller":"traceutil/trace.go:171","msg":"trace[512702997] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"298.006081ms","start":"2026-05-07T20:54:45.745355Z","end":"2026-05-07T20:54:46.043361Z","steps":["trace[512702997] 'process raft request' (duration: 297.23091ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:46.044504Z","caller":"traceutil/trace.go:171","msg":"trace[812497418] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"286.465361ms","start":"2026-05-07T20:54:45.757942Z","end":"2026-05-07T20:54:46.044408Z","steps":["trace[812497418] 'process raft request' (duration: 285.343152ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:46.04891Z","caller":"traceutil/trace.go:171","msg":"trace[358230649] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"270.479568ms","start":"2026-05-07T20:54:45.778415Z","end":"2026-05-07T20:54:46.048895Z","steps":["trace[358230649] 'process raft request' (duration: 266.493095ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:52.895162Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226012704566551,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-07T20:54:53.297653Z","caller":"traceutil/trace.go:171","msg":"trace[1621847349] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:643; }","duration":"903.128367ms","start":"2026-05-07T20:54:52.394495Z","end":"2026-05-07T20:54:53.297623Z","steps":["trace[1621847349] 'read index received' (duration: 880.006999ms)","trace[1621847349] 'applied index is now lower than readState.Index' (duration: 23.120128ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T20:54:53.297863Z","caller":"traceutil/trace.go:171","msg":"trace[140003132] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"940.188266ms","start":"2026-05-07T20:54:52.357591Z","end":"2026-05-07T20:54:53.297779Z","steps":["trace[140003132] 'process raft request' (duration: 916.981784ms)","trace[140003132] 'compare' (duration: 22.293537ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T20:54:53.297971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.646536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-07T20:54:53.298009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:52.357567Z","time spent":"940.37082ms","remote":"127.0.0.1:41532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T20:54:53.29803Z","caller":"traceutil/trace.go:171","msg":"trace[1438350243] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"766.776418ms","start":"2026-05-07T20:54:52.531235Z","end":"2026-05-07T20:54:53.298012Z","steps":["trace[1438350243] 'agreement among raft nodes before linearized reading' (duration: 766.680146ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:53.29808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:52.531205Z","time spent":"766.862281ms","remote":"127.0.0.1:41292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-07T20:54:53.298126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.501ms","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-07T20:54:53.298172Z","caller":"traceutil/trace.go:171","msg":"trace[1061922323] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:623; }","duration":"495.544391ms","start":"2026-05-07T20:54:52.802614Z","end":"2026-05-07T20:54:53.298158Z","steps":["trace[1061922323] 'agreement among raft nodes before linearized reading' (duration: 495.429798ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:53.298208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:52.802535Z","time spent":"495.663144ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-07T20:54:53.298317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.293699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-07T20:54:53.298377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.920016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-q2n2v\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-07T20:54:53.298391Z","caller":"traceutil/trace.go:171","msg":"trace[1189799728] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:623; }","duration":"494.400401ms","start":"2026-05-07T20:54:52.803968Z","end":"2026-05-07T20:54:53.298368Z","steps":["trace[1189799728] 'agreement among raft nodes before linearized reading' (duration: 494.166035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:53.297978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"903.471956ms","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-07T20:54:53.29843Z","caller":"traceutil/trace.go:171","msg":"trace[821382994] range","detail":"{range_begin:/registry/pods/kube-system/cilium-q2n2v; range_end:; response_count:1; response_revision:623; }","duration":"645.012889ms","start":"2026-05-07T20:54:52.653403Z","end":"2026-05-07T20:54:53.298416Z","steps":["trace[821382994] 'agreement among raft nodes before linearized reading' (duration: 644.879525ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:53.298438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:52.803959Z","time spent":"494.470615ms","remote":"127.0.0.1:41554","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-07T20:54:53.298451Z","caller":"traceutil/trace.go:171","msg":"trace[1357035305] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:623; }","duration":"903.97926ms","start":"2026-05-07T20:54:52.394454Z","end":"2026-05-07T20:54:53.298433Z","steps":["trace[1357035305] 'agreement among raft nodes before linearized reading' (duration: 903.331963ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:53.298472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:52.653383Z","time spent":"645.07753ms","remote":"127.0.0.1:41464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-q2n2v\" "} {"level":"warn","ts":"2026-05-07T20:54:53.298502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:52.394432Z","time spent":"904.052261ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-07T20:54:53.305607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.455845ms","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-07T20:54:53.305747Z","caller":"traceutil/trace.go:171","msg":"trace[310858530] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:623; }","duration":"501.930337ms","start":"2026-05-07T20:54:52.803786Z","end":"2026-05-07T20:54:53.305717Z","steps":["trace[310858530] 'agreement among raft nodes before linearized reading' (duration: 494.224277ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:53.30679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:52.803753Z","time spent":"503.009715ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-07T20:54:54.695684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.086121331s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T20:54:54.69598Z","caller":"traceutil/trace.go:171","msg":"trace[1602171271] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"1.38442517s","start":"2026-05-07T20:54:53.311539Z","end":"2026-05-07T20:54:54.695964Z","steps":["trace[1602171271] 'process raft request' (duration: 1.384368178s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:54.696069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:53.311526Z","time spent":"1.384506301s","remote":"127.0.0.1:41464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T20:54:54.696084Z","caller":"traceutil/trace.go:171","msg":"trace[189476311] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"1.389362548s","start":"2026-05-07T20:54:53.306677Z","end":"2026-05-07T20:54:54.69604Z","steps":["trace[189476311] 'process raft request' (duration: 1.389101941s)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:54.696195Z","caller":"traceutil/trace.go:171","msg":"trace[889939549] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"1.386552714s","start":"2026-05-07T20:54:53.309606Z","end":"2026-05-07T20:54:54.696159Z","steps":["trace[889939549] 'process raft request' (duration: 1.386251196s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:54.696262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:53.306664Z","time spent":"1.389505511s","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T20:54:54.696371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:53.30959Z","time spent":"1.386689296s","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T20:54:54.696602Z","caller":"traceutil/trace.go:171","msg":"trace[1559775245] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"1.39331118s","start":"2026-05-07T20:54:53.303275Z","end":"2026-05-07T20:54:54.696586Z","steps":["trace[1559775245] 'process raft request' (duration: 306.186823ms)","trace[1559775245] 'compare' (duration: 1.085976727s)"],"step_count":2} {"level":"info","ts":"2026-05-07T20:54:54.696643Z","caller":"traceutil/trace.go:171","msg":"trace[183055981] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:644; }","duration":"1.392496168s","start":"2026-05-07T20:54:53.304137Z","end":"2026-05-07T20:54:54.696633Z","steps":["trace[183055981] 'read index received' (duration: 305.33636ms)","trace[183055981] 'applied index is now lower than readState.Index' (duration: 1.087158678s)"],"step_count":2} {"level":"warn","ts":"2026-05-07T20:54:54.696704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.39256101s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-07T20:54:54.69719Z","caller":"traceutil/trace.go:171","msg":"trace[497836438] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:628; }","duration":"1.393055211s","start":"2026-05-07T20:54:53.304109Z","end":"2026-05-07T20:54:54.697164Z","steps":["trace[497836438] 'agreement among raft nodes before linearized reading' (duration: 1.392554399s)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:54.696793Z","caller":"traceutil/trace.go:171","msg":"trace[1553684931] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"1.389369348s","start":"2026-05-07T20:54:53.307414Z","end":"2026-05-07T20:54:54.696784Z","steps":["trace[1553684931] 'process raft request' (duration: 1.388409643s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:54.697241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:53.3041Z","time spent":"1.393120094s","remote":"127.0.0.1:41490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-05-07T20:54:54.697323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:53.307406Z","time spent":"1.38985635s","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T20:54:54.699606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:53.303249Z","time spent":"1.393809742s","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T20:54:55.28068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.876747ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-07T20:54:55.280904Z","caller":"traceutil/trace.go:171","msg":"trace[731329637] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:649; }","duration":"583.752404ms","start":"2026-05-07T20:54:54.69713Z","end":"2026-05-07T20:54:55.280882Z","steps":["trace[731329637] 'read index received' (duration: 50.622811ms)","trace[731329637] 'applied index is now lower than readState.Index' (duration: 533.127003ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T20:54:55.281031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"752.378836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T20:54:55.281095Z","caller":"traceutil/trace.go:171","msg":"trace[2058474997] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:628; }","duration":"752.48327ms","start":"2026-05-07T20:54:54.528597Z","end":"2026-05-07T20:54:55.281081Z","steps":["trace[2058474997] 'agreement among raft nodes before linearized reading' (duration: 752.364246ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:55.281128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:54.528582Z","time spent":"752.541541ms","remote":"127.0.0.1:41292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-07T20:54:55.281264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.648353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-07T20:54:55.281333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.748872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T20:54:55.281365Z","caller":"traceutil/trace.go:171","msg":"trace[799500713] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:628; }","duration":"207.788326ms","start":"2026-05-07T20:54:55.073554Z","end":"2026-05-07T20:54:55.281342Z","steps":["trace[799500713] 'agreement among raft nodes before linearized reading' (duration: 207.611502ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:55.281403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.604059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-07T20:54:55.281414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.301938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T20:54:55.281431Z","caller":"traceutil/trace.go:171","msg":"trace[1664342488] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:628; }","duration":"222.667611ms","start":"2026-05-07T20:54:55.058756Z","end":"2026-05-07T20:54:55.281424Z","steps":["trace[1664342488] 'agreement among raft nodes before linearized reading' (duration: 222.6312ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:55.281322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.993705ms","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-07T20:54:55.281463Z","caller":"traceutil/trace.go:171","msg":"trace[1798515510] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:628; }","duration":"223.367159ms","start":"2026-05-07T20:54:55.058079Z","end":"2026-05-07T20:54:55.281446Z","steps":["trace[1798515510] 'agreement among raft nodes before linearized reading' (duration: 223.306437ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:55.281477Z","caller":"traceutil/trace.go:171","msg":"trace[2129517348] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:628; }","duration":"132.157339ms","start":"2026-05-07T20:54:55.149307Z","end":"2026-05-07T20:54:55.281464Z","steps":["trace[2129517348] 'agreement among raft nodes before linearized reading' (duration: 131.916433ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:55.281416Z","caller":"traceutil/trace.go:171","msg":"trace[1020940924] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:628; }","duration":"186.865885ms","start":"2026-05-07T20:54:55.094531Z","end":"2026-05-07T20:54:55.281397Z","steps":["trace[1020940924] 'agreement among raft nodes before linearized reading' (duration: 186.733082ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:55.28137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.994709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T20:54:55.281604Z","caller":"traceutil/trace.go:171","msg":"trace[764570980] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:628; }","duration":"223.239105ms","start":"2026-05-07T20:54:55.058361Z","end":"2026-05-07T20:54:55.2816Z","steps":["trace[764570980] 'agreement among raft nodes before linearized reading' (duration: 222.982449ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:55.28142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.927324ms","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":"warn","ts":"2026-05-07T20:54:55.281424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.003237ms","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-07T20:54:55.281702Z","caller":"traceutil/trace.go:171","msg":"trace[1382256362] 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:628; }","duration":"110.319534ms","start":"2026-05-07T20:54:55.171376Z","end":"2026-05-07T20:54:55.281696Z","steps":["trace[1382256362] 'agreement among raft nodes before linearized reading' (duration: 110.004576ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:55.281723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.752664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-07T20:54:55.281665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.089661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T20:54:55.281779Z","caller":"traceutil/trace.go:171","msg":"trace[534714470] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:628; }","duration":"207.844647ms","start":"2026-05-07T20:54:55.07392Z","end":"2026-05-07T20:54:55.281765Z","steps":["trace[534714470] 'agreement among raft nodes before linearized reading' (duration: 207.774035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:55.281792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.390484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T20:54:55.281782Z","caller":"traceutil/trace.go:171","msg":"trace[1494236455] 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:628; }","duration":"110.242272ms","start":"2026-05-07T20:54:55.171425Z","end":"2026-05-07T20:54:55.281667Z","steps":["trace[1494236455] 'agreement among raft nodes before linearized reading' (duration: 109.905034ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:55.281835Z","caller":"traceutil/trace.go:171","msg":"trace[823811432] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:628; }","duration":"186.443955ms","start":"2026-05-07T20:54:55.095377Z","end":"2026-05-07T20:54:55.281821Z","steps":["trace[823811432] 'agreement among raft nodes before linearized reading' (duration: 186.382943ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:55.281359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.776436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T20:54:55.281916Z","caller":"traceutil/trace.go:171","msg":"trace[950522079] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:628; }","duration":"208.356041ms","start":"2026-05-07T20:54:55.073554Z","end":"2026-05-07T20:54:55.28191Z","steps":["trace[950522079] 'agreement among raft nodes before linearized reading' (duration: 207.764616ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:55.281285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.670121ms","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":"warn","ts":"2026-05-07T20:54:55.281312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.845652ms","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":"info","ts":"2026-05-07T20:54:55.281976Z","caller":"traceutil/trace.go:171","msg":"trace[126935469] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:628; }","duration":"298.435381ms","start":"2026-05-07T20:54:54.983524Z","end":"2026-05-07T20:54:55.28196Z","steps":["trace[126935469] 'agreement among raft nodes before linearized reading' (duration: 297.661731ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:55.281807Z","caller":"traceutil/trace.go:171","msg":"trace[1858411428] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:628; }","duration":"187.270976ms","start":"2026-05-07T20:54:55.09453Z","end":"2026-05-07T20:54:55.281801Z","steps":["trace[1858411428] 'agreement among raft nodes before linearized reading' (duration: 187.093681ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:55.282093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.479788ms","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-07T20:54:55.282107Z","caller":"traceutil/trace.go:171","msg":"trace[1441709027] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:628; }","duration":"299.51735ms","start":"2026-05-07T20:54:54.982586Z","end":"2026-05-07T20:54:55.282103Z","steps":["trace[1441709027] 'agreement among raft nodes before linearized reading' (duration: 299.496279ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:55.282073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.458041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-07T20:54:55.282181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.52672ms","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-07T20:54:55.282219Z","caller":"traceutil/trace.go:171","msg":"trace[251314151] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:628; }","duration":"313.594454ms","start":"2026-05-07T20:54:54.968591Z","end":"2026-05-07T20:54:55.282186Z","steps":["trace[251314151] 'agreement among raft nodes before linearized reading' (duration: 313.463841ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:55.282234Z","caller":"traceutil/trace.go:171","msg":"trace[132891085] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:628; }","duration":"299.659034ms","start":"2026-05-07T20:54:54.98256Z","end":"2026-05-07T20:54:55.282219Z","steps":["trace[132891085] 'agreement among raft nodes before linearized reading' (duration: 299.52534ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:55.281729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.443336ms","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":"warn","ts":"2026-05-07T20:54:55.282294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:54.968584Z","time spent":"313.690736ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-07T20:54:55.282312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.878871ms","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-07T20:54:55.282338Z","caller":"traceutil/trace.go:171","msg":"trace[1353105277] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:628; }","duration":"313.947312ms","start":"2026-05-07T20:54:54.968386Z","end":"2026-05-07T20:54:55.282334Z","steps":["trace[1353105277] 'agreement among raft nodes before linearized reading' (duration: 313.910551ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:55.282359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:54.968358Z","time spent":"313.996414ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"info","ts":"2026-05-07T20:54:55.281999Z","caller":"traceutil/trace.go:171","msg":"trace[1278232238] 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:628; }","duration":"110.581911ms","start":"2026-05-07T20:54:55.171412Z","end":"2026-05-07T20:54:55.281994Z","steps":["trace[1278232238] 'agreement among raft nodes before linearized reading' (duration: 109.862472ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:54:55.282301Z","caller":"traceutil/trace.go:171","msg":"trace[683111405] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:628; }","duration":"133.041232ms","start":"2026-05-07T20:54:55.149243Z","end":"2026-05-07T20:54:55.282284Z","steps":["trace[683111405] 'agreement among raft nodes before linearized reading' (duration: 132.441206ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:55.282513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.095828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T20:54:55.282535Z","caller":"traceutil/trace.go:171","msg":"trace[14935503] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:628; }","duration":"314.161529ms","start":"2026-05-07T20:54:54.968366Z","end":"2026-05-07T20:54:55.282528Z","steps":["trace[14935503] 'agreement among raft nodes before linearized reading' (duration: 314.130558ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:55.28255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:54.968344Z","time spent":"314.201459ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-07T20:54:55.282804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.071911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T20:54:55.282925Z","caller":"traceutil/trace.go:171","msg":"trace[571516072] range","detail":"{range_begin:/registry/limitranges/envoy-gateway-system/; range_end:/registry/limitranges/envoy-gateway-system0; response_count:0; response_revision:628; }","duration":"577.174923ms","start":"2026-05-07T20:54:54.705665Z","end":"2026-05-07T20:54:55.28284Z","steps":["trace[571516072] 'agreement among raft nodes before linearized reading' (duration: 575.480419ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:54:55.282973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:54:54.705651Z","time spent":"577.309407ms","remote":"127.0.0.1:41414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-05-07T20:54:55.28353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.545873ms","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-07T20:54:55.283627Z","caller":"traceutil/trace.go:171","msg":"trace[1350553771] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:628; }","duration":"133.712889ms","start":"2026-05-07T20:54:55.149893Z","end":"2026-05-07T20:54:55.283606Z","steps":["trace[1350553771] 'agreement among raft nodes before linearized reading' (duration: 131.562584ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:55:09.2209Z","caller":"traceutil/trace.go:171","msg":"trace[1014539093] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"159.22706ms","start":"2026-05-07T20:55:09.061648Z","end":"2026-05-07T20:55:09.220875Z","steps":["trace[1014539093] 'process raft request' (duration: 159.044176ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:55:11.135975Z","caller":"traceutil/trace.go:171","msg":"trace[507330527] linearizableReadLoop","detail":"{readStateIndex:815; appliedIndex:814; }","duration":"386.070298ms","start":"2026-05-07T20:55:10.749879Z","end":"2026-05-07T20:55:11.135949Z","steps":["trace[507330527] 'read index received' (duration: 385.853433ms)","trace[507330527] 'applied index is now lower than readState.Index' (duration: 215.735µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T20:55:11.136033Z","caller":"traceutil/trace.go:171","msg":"trace[425013058] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"430.865287ms","start":"2026-05-07T20:55:10.705145Z","end":"2026-05-07T20:55:11.13601Z","steps":["trace[425013058] 'process raft request' (duration: 430.658232ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:55:11.136182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:55:10.705124Z","time spent":"430.964301ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T20:55:11.136356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.245972ms","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-07T20:55:11.1364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.569009ms","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-07T20:55:11.136445Z","caller":"traceutil/trace.go:171","msg":"trace[1209532157] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:789; }","duration":"280.6356ms","start":"2026-05-07T20:55:10.855796Z","end":"2026-05-07T20:55:11.136432Z","steps":["trace[1209532157] 'agreement among raft nodes before linearized reading' (duration: 280.509047ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:55:11.136425Z","caller":"traceutil/trace.go:171","msg":"trace[1390878249] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:789; }","duration":"258.348504ms","start":"2026-05-07T20:55:10.878061Z","end":"2026-05-07T20:55:11.13641Z","steps":["trace[1390878249] 'agreement among raft nodes before linearized reading' (duration: 258.148639ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:55:11.136454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.493797ms","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-07T20:55:11.136532Z","caller":"traceutil/trace.go:171","msg":"trace[2039343408] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:789; }","duration":"280.60195ms","start":"2026-05-07T20:55:10.855911Z","end":"2026-05-07T20:55:11.136513Z","steps":["trace[2039343408] 'agreement among raft nodes before linearized reading' (duration: 280.355604ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:55:11.136515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.28431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-07T20:55:11.136619Z","caller":"traceutil/trace.go:171","msg":"trace[1981068861] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:789; }","duration":"283.429283ms","start":"2026-05-07T20:55:10.853165Z","end":"2026-05-07T20:55:11.136595Z","steps":["trace[1981068861] 'agreement among raft nodes before linearized reading' (duration: 283.231508ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:55:11.136367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.394587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2827g\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-05-07T20:55:11.136966Z","caller":"traceutil/trace.go:171","msg":"trace[1585714417] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2827g; range_end:; response_count:1; response_revision:789; }","duration":"387.110966ms","start":"2026-05-07T20:55:10.749836Z","end":"2026-05-07T20:55:11.136947Z","steps":["trace[1585714417] 'agreement among raft nodes before linearized reading' (duration: 386.229392ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:55:11.137018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:55:10.749817Z","time spent":"387.182897ms","remote":"127.0.0.1:41464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2827g\" "} {"level":"info","ts":"2026-05-07T20:55:11.262837Z","caller":"traceutil/trace.go:171","msg":"trace[1819955484] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"122.267224ms","start":"2026-05-07T20:55:11.14054Z","end":"2026-05-07T20:55:11.262807Z","steps":["trace[1819955484] 'process raft request' (duration: 119.703047ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:55:11.265741Z","caller":"traceutil/trace.go:171","msg":"trace[1694348010] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"124.184064ms","start":"2026-05-07T20:55:11.141542Z","end":"2026-05-07T20:55:11.265726Z","steps":["trace[1694348010] 'process raft request' (duration: 124.119052ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:55:11.265822Z","caller":"traceutil/trace.go:171","msg":"trace[1121185909] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"125.000194ms","start":"2026-05-07T20:55:11.140784Z","end":"2026-05-07T20:55:11.265784Z","steps":["trace[1121185909] 'process raft request' (duration: 124.792068ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:55:11.266339Z","caller":"traceutil/trace.go:171","msg":"trace[1264083639] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"123.24088ms","start":"2026-05-07T20:55:11.143086Z","end":"2026-05-07T20:55:11.266326Z","steps":["trace[1264083639] 'process raft request' (duration: 123.149686ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:55:11.266417Z","caller":"traceutil/trace.go:171","msg":"trace[1852317955] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"124.645715ms","start":"2026-05-07T20:55:11.141737Z","end":"2026-05-07T20:55:11.266383Z","steps":["trace[1852317955] 'process raft request' (duration: 123.958627ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:55:15.949328Z","caller":"traceutil/trace.go:171","msg":"trace[1483495225] transaction","detail":"{read_only:false; response_revision:846; number_of_response:1; }","duration":"144.268262ms","start":"2026-05-07T20:55:15.805024Z","end":"2026-05-07T20:55:15.949293Z","steps":["trace[1483495225] 'process raft request' (duration: 114.590674ms)","trace[1483495225] 'compare' (duration: 29.460052ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T20:55:19.3548Z","caller":"traceutil/trace.go:171","msg":"trace[1640245269] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"126.148053ms","start":"2026-05-07T20:55:19.228625Z","end":"2026-05-07T20:55:19.354773Z","steps":["trace[1640245269] 'process raft request' (duration: 125.99486ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:55:20.057706Z","caller":"traceutil/trace.go:171","msg":"trace[1382201673] transaction","detail":"{read_only:false; response_revision:892; number_of_response:1; }","duration":"106.368992ms","start":"2026-05-07T20:55:19.951313Z","end":"2026-05-07T20:55:20.057682Z","steps":["trace[1382201673] 'process raft request' (duration: 106.316571ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:55:20.057762Z","caller":"traceutil/trace.go:171","msg":"trace[1464072213] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"107.581494ms","start":"2026-05-07T20:55:19.950149Z","end":"2026-05-07T20:55:20.057731Z","steps":["trace[1464072213] 'process raft request' (duration: 107.230784ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:55:20.217452Z","caller":"traceutil/trace.go:171","msg":"trace[1629491103] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"130.171148ms","start":"2026-05-07T20:55:20.087259Z","end":"2026-05-07T20:55:20.21743Z","steps":["trace[1629491103] 'process raft request' (duration: 117.299705ms)","trace[1629491103] 'compare' (duration: 12.76653ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T20:55:20.220126Z","caller":"traceutil/trace.go:171","msg":"trace[1401544862] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"130.948678ms","start":"2026-05-07T20:55:20.089145Z","end":"2026-05-07T20:55:20.220093Z","steps":["trace[1401544862] 'process raft request' (duration: 130.720022ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:55:20.220187Z","caller":"traceutil/trace.go:171","msg":"trace[992377428] transaction","detail":"{read_only:false; response_revision:899; number_of_response:1; }","duration":"130.134277ms","start":"2026-05-07T20:55:20.090023Z","end":"2026-05-07T20:55:20.220157Z","steps":["trace[992377428] 'process raft request' (duration: 129.966643ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:55:20.220249Z","caller":"traceutil/trace.go:171","msg":"trace[695603635] linearizableReadLoop","detail":"{readStateIndex:926; appliedIndex:924; }","duration":"130.224989ms","start":"2026-05-07T20:55:20.090005Z","end":"2026-05-07T20:55:20.22023Z","steps":["trace[695603635] 'read index received' (duration: 114.490983ms)","trace[695603635] 'applied index is now lower than readState.Index' (duration: 15.732896ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T20:55:20.220317Z","caller":"traceutil/trace.go:171","msg":"trace[108878534] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"130.174218ms","start":"2026-05-07T20:55:20.090121Z","end":"2026-05-07T20:55:20.220295Z","steps":["trace[108878534] 'process raft request' (duration: 129.983333ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:55:20.220467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.435184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-h22hv\" ","response":"range_response_count:1 size:4884"} {"level":"info","ts":"2026-05-07T20:55:20.220477Z","caller":"traceutil/trace.go:171","msg":"trace[140403987] transaction","detail":"{read_only:false; response_revision:900; number_of_response:1; }","duration":"130.367182ms","start":"2026-05-07T20:55:20.090079Z","end":"2026-05-07T20:55:20.220446Z","steps":["trace[140403987] 'process raft request' (duration: 129.976273ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:55:20.220477Z","caller":"traceutil/trace.go:171","msg":"trace[651383630] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"128.414972ms","start":"2026-05-07T20:55:20.092023Z","end":"2026-05-07T20:55:20.220438Z","steps":["trace[651383630] 'process raft request' (duration: 128.146146ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:55:20.220529Z","caller":"traceutil/trace.go:171","msg":"trace[1753226349] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-h22hv; range_end:; response_count:1; response_revision:902; }","duration":"130.533978ms","start":"2026-05-07T20:55:20.089978Z","end":"2026-05-07T20:55:20.220512Z","steps":["trace[1753226349] 'agreement among raft nodes before linearized reading' (duration: 130.328012ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:55:37.663735Z","caller":"traceutil/trace.go:171","msg":"trace[1021565628] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"174.929742ms","start":"2026-05-07T20:55:37.488778Z","end":"2026-05-07T20:55:37.663707Z","steps":["trace[1021565628] 'process raft request' (duration: 174.648835ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:55:37.663845Z","caller":"traceutil/trace.go:171","msg":"trace[1848547206] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"172.921449ms","start":"2026-05-07T20:55:37.490911Z","end":"2026-05-07T20:55:37.663832Z","steps":["trace[1848547206] 'process raft request' (duration: 172.660812ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:55:37.663968Z","caller":"traceutil/trace.go:171","msg":"trace[1369871081] linearizableReadLoop","detail":"{readStateIndex:1005; appliedIndex:1002; }","duration":"133.082422ms","start":"2026-05-07T20:55:37.530722Z","end":"2026-05-07T20:55:37.663804Z","steps":["trace[1369871081] 'read index received' (duration: 34.97436ms)","trace[1369871081] 'applied index is now lower than readState.Index' (duration: 98.107442ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T20:55:37.663991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.236076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T20:55:37.664056Z","caller":"traceutil/trace.go:171","msg":"trace[1486757272] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:973; }","duration":"133.341339ms","start":"2026-05-07T20:55:37.5307Z","end":"2026-05-07T20:55:37.664041Z","steps":["trace[1486757272] 'agreement among raft nodes before linearized reading' (duration: 133.205266ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:55:46.064331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.965814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-07T20:55:46.064402Z","caller":"traceutil/trace.go:171","msg":"trace[1181052358] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1001; }","duration":"473.077057ms","start":"2026-05-07T20:55:45.591308Z","end":"2026-05-07T20:55:46.064385Z","steps":["trace[1181052358] 'range keys from in-memory index tree' (duration: 472.797551ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:55:46.06444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:55:45.591284Z","time spent":"473.147659ms","remote":"127.0.0.1:41554","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-07T20:55:46.064532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.676939ms","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-07T20:55:46.064602Z","caller":"traceutil/trace.go:171","msg":"trace[873369081] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1001; }","duration":"374.801872ms","start":"2026-05-07T20:55:45.689784Z","end":"2026-05-07T20:55:46.064586Z","steps":["trace[873369081] 'range keys from in-memory index tree' (duration: 374.504153ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:55:46.064638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:55:45.689761Z","time spent":"374.867923ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-07T20:55:46.064532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.197954ms","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-07T20:55:46.064689Z","caller":"traceutil/trace.go:171","msg":"trace[1054054555] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1001; }","duration":"372.389828ms","start":"2026-05-07T20:55:45.692277Z","end":"2026-05-07T20:55:46.064666Z","steps":["trace[1054054555] 'range keys from in-memory index tree' (duration: 372.003648ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:55:46.064735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:55:45.692259Z","time spent":"372.45237ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-07T20:55:46.7526Z","caller":"traceutil/trace.go:171","msg":"trace[295854592] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"685.058783ms","start":"2026-05-07T20:55:46.06752Z","end":"2026-05-07T20:55:46.752579Z","steps":["trace[295854592] 'process raft request' (duration: 684.896989ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:55:46.752806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:55:46.067505Z","time spent":"685.154935ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T20:55:47.508177Z","caller":"traceutil/trace.go:171","msg":"trace[1265777453] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"1.439949384s","start":"2026-05-07T20:55:46.068206Z","end":"2026-05-07T20:55:47.508155Z","steps":["trace[1265777453] 'process raft request' (duration: 1.439729188s)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:55:47.50827Z","caller":"traceutil/trace.go:171","msg":"trace[1728071992] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"1.439622205s","start":"2026-05-07T20:55:46.06862Z","end":"2026-05-07T20:55:47.508242Z","steps":["trace[1728071992] 'process raft request' (duration: 1.439484822s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:55:47.508293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:55:46.068198Z","time spent":"1.440032386s","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T20:55:47.508282Z","caller":"traceutil/trace.go:171","msg":"trace[185552847] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"1.345414385s","start":"2026-05-07T20:55:46.162853Z","end":"2026-05-07T20:55:47.508268Z","steps":["trace[185552847] 'process raft request' (duration: 1.345290702s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:55:47.508396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:55:46.068613Z","time spent":"1.439712508s","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T20:55:47.508416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:55:46.16284Z","time spent":"1.345502517s","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T20:55:47.508489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"978.443637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T20:55:47.50852Z","caller":"traceutil/trace.go:171","msg":"trace[240349505] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1005; }","duration":"978.505649ms","start":"2026-05-07T20:55:46.530004Z","end":"2026-05-07T20:55:47.50851Z","steps":["trace[240349505] 'agreement among raft nodes before linearized reading' (duration: 978.455897ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:55:47.50854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:55:46.529987Z","time spent":"978.548419ms","remote":"127.0.0.1:41292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-07T20:55:47.508215Z","caller":"traceutil/trace.go:171","msg":"trace[65461360] linearizableReadLoop","detail":"{readStateIndex:1039; appliedIndex:1035; }","duration":"978.142949ms","start":"2026-05-07T20:55:46.53005Z","end":"2026-05-07T20:55:47.508193Z","steps":["trace[65461360] 'read index received' (duration: 222.463438ms)","trace[65461360] 'applied index is now lower than readState.Index' (duration: 755.678391ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T20:55:47.662172Z","caller":"traceutil/trace.go:171","msg":"trace[234576076] linearizableReadLoop","detail":"{readStateIndex:1040; appliedIndex:1039; }","duration":"126.149122ms","start":"2026-05-07T20:55:47.536002Z","end":"2026-05-07T20:55:47.662151Z","steps":["trace[234576076] 'read index received' (duration: 70.423482ms)","trace[234576076] 'applied index is now lower than readState.Index' (duration: 55.72471ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T20:55:47.66226Z","caller":"traceutil/trace.go:171","msg":"trace[45878599] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"149.320825ms","start":"2026-05-07T20:55:47.512912Z","end":"2026-05-07T20:55:47.662233Z","steps":["trace[45878599] 'process raft request' (duration: 93.482892ms)","trace[45878599] 'compare' (duration: 55.649608ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T20:55:47.662431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.41732ms","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-07T20:55:47.66254Z","caller":"traceutil/trace.go:171","msg":"trace[319581670] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1006; }","duration":"126.569552ms","start":"2026-05-07T20:55:47.535954Z","end":"2026-05-07T20:55:47.662523Z","steps":["trace[319581670] 'agreement among raft nodes before linearized reading' (duration: 126.278125ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:55:53.815217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.879347ms","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-07T20:55:53.815275Z","caller":"traceutil/trace.go:171","msg":"trace[413791750] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1026; }","duration":"132.970859ms","start":"2026-05-07T20:55:53.682292Z","end":"2026-05-07T20:55:53.815262Z","steps":["trace[413791750] 'range keys from in-memory index tree' (duration: 132.740353ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:55:53.923403Z","caller":"traceutil/trace.go:171","msg":"trace[1185512188] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"101.694956ms","start":"2026-05-07T20:55:53.821691Z","end":"2026-05-07T20:55:53.923386Z","steps":["trace[1185512188] 'process raft request' (duration: 101.594214ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:55:59.713247Z","caller":"traceutil/trace.go:171","msg":"trace[84292188] linearizableReadLoop","detail":"{readStateIndex:1080; appliedIndex:1079; }","duration":"111.939423ms","start":"2026-05-07T20:55:59.601282Z","end":"2026-05-07T20:55:59.713222Z","steps":["trace[84292188] 'read index received' (duration: 95.514495ms)","trace[84292188] 'applied index is now lower than readState.Index' (duration: 16.423648ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T20:55:59.713289Z","caller":"traceutil/trace.go:171","msg":"trace[331760282] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"118.135764ms","start":"2026-05-07T20:55:59.595123Z","end":"2026-05-07T20:55:59.713259Z","steps":["trace[331760282] 'process raft request' (duration: 101.684916ms)","trace[331760282] 'compare' (duration: 16.211452ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T20:55:59.713403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.108717ms","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-07T20:55:59.713461Z","caller":"traceutil/trace.go:171","msg":"trace[277239939] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1043; }","duration":"112.202919ms","start":"2026-05-07T20:55:59.601243Z","end":"2026-05-07T20:55:59.713446Z","steps":["trace[277239939] 'agreement among raft nodes before linearized reading' (duration: 112.082786ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:56:11.421422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.555531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T20:56:11.421529Z","caller":"traceutil/trace.go:171","msg":"trace[686854748] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1081; }","duration":"488.722886ms","start":"2026-05-07T20:56:10.932784Z","end":"2026-05-07T20:56:11.421507Z","steps":["trace[686854748] 'count revisions from in-memory index tree' (duration: 488.465689ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:56:11.42159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:56:10.932766Z","time spent":"488.806767ms","remote":"127.0.0.1:41418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":27,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-05-07T20:56:11.421648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.486777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-07T20:56:11.421745Z","caller":"traceutil/trace.go:171","msg":"trace[2043228281] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1081; }","duration":"461.62868ms","start":"2026-05-07T20:56:10.960092Z","end":"2026-05-07T20:56:11.421721Z","steps":["trace[2043228281] 'range keys from in-memory index tree' (duration: 461.307462ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:56:11.421807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:56:10.960075Z","time spent":"461.717583ms","remote":"127.0.0.1:41554","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-07T20:56:11.422159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.252761ms","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-07T20:56:11.422272Z","caller":"traceutil/trace.go:171","msg":"trace[1772289410] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1081; }","duration":"112.398144ms","start":"2026-05-07T20:56:11.309856Z","end":"2026-05-07T20:56:11.422254Z","steps":["trace[1772289410] 'range keys from in-memory index tree' (duration: 112.23693ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:56:11.715573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.858424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T20:56:11.715698Z","caller":"traceutil/trace.go:171","msg":"trace[354114175] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1082; }","duration":"186.018609ms","start":"2026-05-07T20:56:11.529656Z","end":"2026-05-07T20:56:11.715675Z","steps":["trace[354114175] 'range keys from in-memory index tree' (duration: 185.769142ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:56:13.97597Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226012704567596,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-07T20:56:14.050485Z","caller":"traceutil/trace.go:171","msg":"trace[1905775609] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"587.950296ms","start":"2026-05-07T20:56:13.46246Z","end":"2026-05-07T20:56:14.05041Z","steps":["trace[1905775609] 'process raft request' (duration: 587.773982ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:56:14.050642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:56:13.462433Z","time spent":"588.124361ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T20:56:15.000353Z","caller":"traceutil/trace.go:171","msg":"trace[365306421] linearizableReadLoop","detail":"{readStateIndex:1129; appliedIndex:1127; }","duration":"1.524922286s","start":"2026-05-07T20:56:13.475404Z","end":"2026-05-07T20:56:15.000326Z","steps":["trace[365306421] 'read index received' (duration: 574.957838ms)","trace[365306421] 'applied index is now lower than readState.Index' (duration: 949.963368ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T20:56:15.000495Z","caller":"traceutil/trace.go:171","msg":"trace[2000567519] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"1.145173707s","start":"2026-05-07T20:56:13.855306Z","end":"2026-05-07T20:56:15.00048Z","steps":["trace[2000567519] 'process raft request' (duration: 1.144864859s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:56:15.000617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.525197333s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-07T20:56:15.000627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:56:13.855281Z","time spent":"1.145257598s","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T20:56:15.000655Z","caller":"traceutil/trace.go:171","msg":"trace[1943394803] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1090; }","duration":"1.525275355s","start":"2026-05-07T20:56:13.47537Z","end":"2026-05-07T20:56:15.000646Z","steps":["trace[1943394803] 'agreement among raft nodes before linearized reading' (duration: 1.525184963s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:56:15.000761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:56:13.475354Z","time spent":"1.525395198s","remote":"127.0.0.1:41600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":16,"response size":29,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"info","ts":"2026-05-07T20:56:15.100983Z","caller":"traceutil/trace.go:171","msg":"trace[1943608870] linearizableReadLoop","detail":"{readStateIndex:1130; appliedIndex:1129; }","duration":"100.519296ms","start":"2026-05-07T20:56:15.000435Z","end":"2026-05-07T20:56:15.100955Z","steps":["trace[1943608870] 'read index received' (duration: 11.294594ms)","trace[1943608870] 'applied index is now lower than readState.Index' (duration: 89.222992ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T20:56:15.101132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.571018595s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-07T20:56:15.101166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"915.305767ms","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-07T20:56:15.101204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.036525821s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-07T20:56:15.101246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.326125533s","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-07T20:56:15.101226Z","caller":"traceutil/trace.go:171","msg":"trace[1385000465] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1090; }","duration":"915.368559ms","start":"2026-05-07T20:56:14.185843Z","end":"2026-05-07T20:56:15.101212Z","steps":["trace[1385000465] 'agreement among raft nodes before linearized reading' (duration: 915.169364ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:56:15.101309Z","caller":"traceutil/trace.go:171","msg":"trace[1012910455] 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:1090; }","duration":"1.326230286s","start":"2026-05-07T20:56:13.775064Z","end":"2026-05-07T20:56:15.101295Z","steps":["trace[1012910455] 'agreement among raft nodes before linearized reading' (duration: 1.326142774s)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:56:15.101313Z","caller":"traceutil/trace.go:171","msg":"trace[1342893526] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1090; }","duration":"1.036678915s","start":"2026-05-07T20:56:14.064609Z","end":"2026-05-07T20:56:15.101288Z","steps":["trace[1342893526] 'agreement among raft nodes before linearized reading' (duration: 1.036451609s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:56:15.101353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:56:13.775044Z","time spent":"1.326294768s","remote":"127.0.0.1:37900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-07T20:56:15.101438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:56:14.185794Z","time spent":"915.544633ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-07T20:56:15.101185Z","caller":"traceutil/trace.go:171","msg":"trace[1073327358] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1090; }","duration":"1.571128208s","start":"2026-05-07T20:56:13.53004Z","end":"2026-05-07T20:56:15.101168Z","steps":["trace[1073327358] 'agreement among raft nodes before linearized reading' (duration: 1.571018025s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:56:15.101525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:56:13.530024Z","time spent":"1.571486766s","remote":"127.0.0.1:41296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-07T20:56:15.101362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:56:14.064588Z","time spent":"1.036764566s","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-07T20:56:15.101356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.14719346s","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-07T20:56:15.101712Z","caller":"traceutil/trace.go:171","msg":"trace[1696548351] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1090; }","duration":"1.147641452s","start":"2026-05-07T20:56:13.954052Z","end":"2026-05-07T20:56:15.101693Z","steps":["trace[1696548351] 'agreement among raft nodes before linearized reading' (duration: 1.146926003s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:56:15.10178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:56:13.954027Z","time spent":"1.147740454s","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-07T20:56:15.101252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.158590885s","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-07T20:56:15.101854Z","caller":"traceutil/trace.go:171","msg":"trace[179710629] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1090; }","duration":"1.159223402s","start":"2026-05-07T20:56:13.942616Z","end":"2026-05-07T20:56:15.101839Z","steps":["trace[179710629] 'agreement among raft nodes before linearized reading' (duration: 1.158538534s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:56:15.101902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:56:13.9426Z","time spent":"1.159283763s","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-07T20:56:27.702864Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226012704567792,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-07T20:56:27.817211Z","caller":"traceutil/trace.go:171","msg":"trace[377579661] linearizableReadLoop","detail":"{readStateIndex:1224; appliedIndex:1223; }","duration":"614.718983ms","start":"2026-05-07T20:56:27.202473Z","end":"2026-05-07T20:56:27.817192Z","steps":["trace[377579661] 'read index received' (duration: 614.534858ms)","trace[377579661] 'applied index is now lower than readState.Index' (duration: 183.615µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T20:56:27.817354Z","caller":"traceutil/trace.go:171","msg":"trace[592893200] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"693.198525ms","start":"2026-05-07T20:56:27.1241Z","end":"2026-05-07T20:56:27.817298Z","steps":["trace[592893200] 'process raft request' (duration: 692.983099ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:56:27.817438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.515143ms","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-07T20:56:27.817458Z","caller":"traceutil/trace.go:171","msg":"trace[978843589] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1180; }","duration":"613.550383ms","start":"2026-05-07T20:56:27.203899Z","end":"2026-05-07T20:56:27.81745Z","steps":["trace[978843589] 'agreement among raft nodes before linearized reading' (duration: 613.509871ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:56:27.817478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:56:27.203887Z","time spent":"613.586674ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-07T20:56:27.8175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:56:27.124062Z","time spent":"693.356589ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T20:56:27.817545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.531421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-07T20:56:27.817392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.899097ms","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-07T20:56:27.817597Z","caller":"traceutil/trace.go:171","msg":"trace[1981220238] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1180; }","duration":"287.620264ms","start":"2026-05-07T20:56:27.529961Z","end":"2026-05-07T20:56:27.817582Z","steps":["trace[1981220238] 'agreement among raft nodes before linearized reading' (duration: 287.538722ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:56:27.817628Z","caller":"traceutil/trace.go:171","msg":"trace[1204589297] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1180; }","duration":"615.183115ms","start":"2026-05-07T20:56:27.202435Z","end":"2026-05-07T20:56:27.817618Z","steps":["trace[1204589297] 'agreement among raft nodes before linearized reading' (duration: 614.853596ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:56:27.817667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:56:27.202416Z","time spent":"615.242597ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-07T20:56:27.817709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.698396ms","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-07T20:56:27.817725Z","caller":"traceutil/trace.go:171","msg":"trace[45230755] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1180; }","duration":"601.715016ms","start":"2026-05-07T20:56:27.216006Z","end":"2026-05-07T20:56:27.817721Z","steps":["trace[45230755] 'agreement among raft nodes before linearized reading' (duration: 601.674695ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:56:27.817738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:56:27.215934Z","time spent":"601.801687ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-07T20:56:27.817826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.136203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-07T20:56:27.817838Z","caller":"traceutil/trace.go:171","msg":"trace[2124407762] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1180; }","duration":"605.186385ms","start":"2026-05-07T20:56:27.212648Z","end":"2026-05-07T20:56:27.817835Z","steps":["trace[2124407762] 'agreement among raft nodes before linearized reading' (duration: 605.120263ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:56:27.817849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:56:27.212631Z","time spent":"605.215716ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-07T20:56:46.113976Z","caller":"traceutil/trace.go:171","msg":"trace[921676378] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"100.324766ms","start":"2026-05-07T20:56:46.013625Z","end":"2026-05-07T20:56:46.11395Z","steps":["trace[921676378] 'process raft request' (duration: 100.08941ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:56:46.500267Z","caller":"traceutil/trace.go:171","msg":"trace[827702796] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"236.522773ms","start":"2026-05-07T20:56:46.263725Z","end":"2026-05-07T20:56:46.500248Z","steps":["trace[827702796] 'process raft request' (duration: 236.408219ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:56:47.600898Z","caller":"traceutil/trace.go:171","msg":"trace[2082042978] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"109.496432ms","start":"2026-05-07T20:56:47.49136Z","end":"2026-05-07T20:56:47.600856Z","steps":["trace[2082042978] 'process raft request' (duration: 81.917483ms)","trace[2082042978] 'compare' (duration: 27.421855ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T20:56:47.668821Z","caller":"traceutil/trace.go:171","msg":"trace[1370740561] linearizableReadLoop","detail":"{readStateIndex:1334; appliedIndex:1331; }","duration":"138.617249ms","start":"2026-05-07T20:56:47.530183Z","end":"2026-05-07T20:56:47.6688Z","steps":["trace[1370740561] 'read index received' (duration: 43.042395ms)","trace[1370740561] 'applied index is now lower than readState.Index' (duration: 95.574034ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T20:56:47.668953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.750492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T20:56:47.668991Z","caller":"traceutil/trace.go:171","msg":"trace[1575513296] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1286; }","duration":"138.821004ms","start":"2026-05-07T20:56:47.53016Z","end":"2026-05-07T20:56:47.668981Z","steps":["trace[1575513296] 'agreement among raft nodes before linearized reading' (duration: 138.751462ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:56:47.66898Z","caller":"traceutil/trace.go:171","msg":"trace[1839415536] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"146.479811ms","start":"2026-05-07T20:56:47.522464Z","end":"2026-05-07T20:56:47.668944Z","steps":["trace[1839415536] 'process raft request' (duration: 146.250015ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:56:47.669417Z","caller":"traceutil/trace.go:171","msg":"trace[1897265397] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"148.274068ms","start":"2026-05-07T20:56:47.52113Z","end":"2026-05-07T20:56:47.669404Z","steps":["trace[1897265397] 'process raft request' (duration: 147.471657ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:56:48.125145Z","caller":"traceutil/trace.go:171","msg":"trace[1407717740] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"202.783397ms","start":"2026-05-07T20:56:47.92234Z","end":"2026-05-07T20:56:48.125123Z","steps":["trace[1407717740] 'process raft request' (duration: 202.662324ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:56:48.149875Z","caller":"traceutil/trace.go:171","msg":"trace[1034886843] linearizableReadLoop","detail":"{readStateIndex:1336; appliedIndex:1334; }","duration":"135.453208ms","start":"2026-05-07T20:56:48.014396Z","end":"2026-05-07T20:56:48.149849Z","steps":["trace[1034886843] 'read index received' (duration: 110.63742ms)","trace[1034886843] 'applied index is now lower than readState.Index' (duration: 24.814418ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T20:56:48.150243Z","caller":"traceutil/trace.go:171","msg":"trace[1189382409] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"174.169551ms","start":"2026-05-07T20:56:47.976043Z","end":"2026-05-07T20:56:48.150213Z","steps":["trace[1189382409] 'process raft request' (duration: 173.611998ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:56:48.150304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.88935ms","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-07T20:56:48.150356Z","caller":"traceutil/trace.go:171","msg":"trace[386976508] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1288; }","duration":"136.000713ms","start":"2026-05-07T20:56:48.014342Z","end":"2026-05-07T20:56:48.150343Z","steps":["trace[386976508] 'agreement among raft nodes before linearized reading' (duration: 135.898ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:56:48.150964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.399072ms","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-07T20:56:48.151015Z","caller":"traceutil/trace.go:171","msg":"trace[812873615] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1288; }","duration":"136.476764ms","start":"2026-05-07T20:56:48.014527Z","end":"2026-05-07T20:56:48.151003Z","steps":["trace[812873615] 'agreement among raft nodes before linearized reading' (duration: 136.150765ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:56:48.369038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.497261ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T20:56:48.369186Z","caller":"traceutil/trace.go:171","msg":"trace[1346940389] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"213.903452ms","start":"2026-05-07T20:56:48.155264Z","end":"2026-05-07T20:56:48.369168Z","steps":["trace[1346940389] 'process raft request' (duration: 30.202675ms)","trace[1346940389] 'compare' (duration: 183.217694ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T20:56:48.459172Z","caller":"traceutil/trace.go:171","msg":"trace[288870171] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"303.441092ms","start":"2026-05-07T20:56:48.155703Z","end":"2026-05-07T20:56:48.459144Z","steps":["trace[288870171] 'process raft request' (duration: 303.380041ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:56:48.459312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:56:48.155691Z","time spent":"303.549715ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T20:56:48.45962Z","caller":"traceutil/trace.go:171","msg":"trace[1902952011] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"304.018927ms","start":"2026-05-07T20:56:48.15559Z","end":"2026-05-07T20:56:48.459609Z","steps":["trace[1902952011] 'process raft request' (duration: 303.35093ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:56:48.459675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:56:48.15556Z","time spent":"304.084088ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T20:56:48.459792Z","caller":"traceutil/trace.go:171","msg":"trace[268340097] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"304.095939ms","start":"2026-05-07T20:56:48.155687Z","end":"2026-05-07T20:56:48.459783Z","steps":["trace[268340097] 'process raft request' (duration: 303.36415ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:56:48.459839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:56:48.155666Z","time spent":"304.146081ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T20:56:58.161927Z","caller":"traceutil/trace.go:171","msg":"trace[224188693] linearizableReadLoop","detail":"{readStateIndex:1399; appliedIndex:1398; }","duration":"300.497086ms","start":"2026-05-07T20:56:57.861405Z","end":"2026-05-07T20:56:58.161902Z","steps":["trace[224188693] 'read index received' (duration: 300.25637ms)","trace[224188693] 'applied index is now lower than readState.Index' (duration: 239.406µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T20:56:58.161987Z","caller":"traceutil/trace.go:171","msg":"trace[778201568] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"471.958069ms","start":"2026-05-07T20:56:57.690007Z","end":"2026-05-07T20:56:58.161965Z","steps":["trace[778201568] 'process raft request' (duration: 471.733463ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:56:58.16212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.68987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-07T20:56:58.162478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:56:57.689982Z","time spent":"472.284487ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T20:56:58.162559Z","caller":"traceutil/trace.go:171","msg":"trace[169459753] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1349; }","duration":"301.170573ms","start":"2026-05-07T20:56:57.861326Z","end":"2026-05-07T20:56:58.162497Z","steps":["trace[169459753] 'agreement among raft nodes before linearized reading' (duration: 300.679991ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:56:58.162694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T20:56:57.861295Z","time spent":"301.354038ms","remote":"127.0.0.1:41430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"info","ts":"2026-05-07T20:56:58.295309Z","caller":"traceutil/trace.go:171","msg":"trace[2066483307] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"127.906833ms","start":"2026-05-07T20:56:58.167371Z","end":"2026-05-07T20:56:58.295278Z","steps":["trace[2066483307] 'process raft request' (duration: 126.410645ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:57:49.046171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.166264ms","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-07T20:57:49.046287Z","caller":"traceutil/trace.go:171","msg":"trace[612388980] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1583; }","duration":"106.323638ms","start":"2026-05-07T20:57:48.939937Z","end":"2026-05-07T20:57:49.046261Z","steps":["trace[612388980] 'range keys from in-memory index tree' (duration: 105.9445ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:57:49.046358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.313688ms","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-07T20:57:49.046482Z","caller":"traceutil/trace.go:171","msg":"trace[1093649701] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1583; }","duration":"106.519053ms","start":"2026-05-07T20:57:48.939937Z","end":"2026-05-07T20:57:49.046456Z","steps":["trace[1093649701] 'range keys from in-memory index tree' (duration: 106.157394ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:57:49.162747Z","caller":"traceutil/trace.go:171","msg":"trace[1456126514] transaction","detail":"{read_only:false; response_revision:1585; number_of_response:1; }","duration":"112.035396ms","start":"2026-05-07T20:57:49.050686Z","end":"2026-05-07T20:57:49.162722Z","steps":["trace[1456126514] 'process raft request' (duration: 100.440096ms)","trace[1456126514] 'compare' (duration: 11.449657ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T20:57:49.16289Z","caller":"traceutil/trace.go:171","msg":"trace[1221285822] transaction","detail":"{read_only:false; response_revision:1586; number_of_response:1; }","duration":"112.076138ms","start":"2026-05-07T20:57:49.050794Z","end":"2026-05-07T20:57:49.16287Z","steps":["trace[1221285822] 'process raft request' (duration: 111.888982ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:57:50.802336Z","caller":"traceutil/trace.go:171","msg":"trace[255416255] transaction","detail":"{read_only:false; response_revision:1591; number_of_response:1; }","duration":"127.562119ms","start":"2026-05-07T20:57:50.674742Z","end":"2026-05-07T20:57:50.802304Z","steps":["trace[255416255] 'process raft request' (duration: 88.001603ms)","trace[255416255] 'compare' (duration: 39.391162ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T20:57:56.969922Z","caller":"traceutil/trace.go:171","msg":"trace[366544652] linearizableReadLoop","detail":"{readStateIndex:1681; appliedIndex:1680; }","duration":"107.011247ms","start":"2026-05-07T20:57:56.86289Z","end":"2026-05-07T20:57:56.969901Z","steps":["trace[366544652] 'read index received' (duration: 106.842722ms)","trace[366544652] 'applied index is now lower than readState.Index' (duration: 167.755µs)"],"step_count":2} {"level":"warn","ts":"2026-05-07T20:57:56.970048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.132539ms","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-07T20:57:56.97014Z","caller":"traceutil/trace.go:171","msg":"trace[53577129] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1619; }","duration":"107.280313ms","start":"2026-05-07T20:57:56.862848Z","end":"2026-05-07T20:57:56.970128Z","steps":["trace[53577129] 'agreement among raft nodes before linearized reading' (duration: 107.14176ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:57:56.96996Z","caller":"traceutil/trace.go:171","msg":"trace[1728040344] transaction","detail":"{read_only:false; response_revision:1619; number_of_response:1; }","duration":"109.612332ms","start":"2026-05-07T20:57:56.860325Z","end":"2026-05-07T20:57:56.969937Z","steps":["trace[1728040344] 'process raft request' (duration: 109.457889ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:58:01.390827Z","caller":"traceutil/trace.go:171","msg":"trace[2121268962] linearizableReadLoop","detail":"{readStateIndex:1703; appliedIndex:1702; }","duration":"117.299563ms","start":"2026-05-07T20:58:01.273507Z","end":"2026-05-07T20:58:01.390807Z","steps":["trace[2121268962] 'read index received' (duration: 114.526561ms)","trace[2121268962] 'applied index is now lower than readState.Index' (duration: 2.772092ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T20:58:01.390959Z","caller":"traceutil/trace.go:171","msg":"trace[1228910473] transaction","detail":"{read_only:false; response_revision:1640; number_of_response:1; }","duration":"157.094366ms","start":"2026-05-07T20:58:01.233839Z","end":"2026-05-07T20:58:01.390934Z","steps":["trace[1228910473] 'process raft request' (duration: 154.254102ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:58:01.391171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.644462ms","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-07T20:58:01.391213Z","caller":"traceutil/trace.go:171","msg":"trace[1018121270] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1640; }","duration":"117.701473ms","start":"2026-05-07T20:58:01.273503Z","end":"2026-05-07T20:58:01.391204Z","steps":["trace[1018121270] 'agreement among raft nodes before linearized reading' (duration: 117.56759ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:58:01.391358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.243802ms","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-07T20:58:01.391474Z","caller":"traceutil/trace.go:171","msg":"trace[211390729] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1640; }","duration":"117.377755ms","start":"2026-05-07T20:58:01.274061Z","end":"2026-05-07T20:58:01.391439Z","steps":["trace[211390729] 'agreement among raft nodes before linearized reading' (duration: 116.994075ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:58:37.133901Z","caller":"traceutil/trace.go:171","msg":"trace[30305494] transaction","detail":"{read_only:false; response_revision:1802; number_of_response:1; }","duration":"221.308151ms","start":"2026-05-07T20:58:36.912567Z","end":"2026-05-07T20:58:37.133875Z","steps":["trace[30305494] 'process raft request' (duration: 221.145127ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:58:42.061756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.400367ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T20:58:42.061895Z","caller":"traceutil/trace.go:171","msg":"trace[608089956] linearizableReadLoop","detail":"{readStateIndex:1897; appliedIndex:1896; }","duration":"237.219963ms","start":"2026-05-07T20:58:41.824652Z","end":"2026-05-07T20:58:42.061872Z","steps":["trace[608089956] 'read index received' (duration: 70.55203ms)","trace[608089956] 'applied index is now lower than readState.Index' (duration: 166.666423ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T20:58:42.06194Z","caller":"traceutil/trace.go:171","msg":"trace[2104427114] transaction","detail":"{read_only:false; response_revision:1826; number_of_response:1; }","duration":"280.028935ms","start":"2026-05-07T20:58:41.78187Z","end":"2026-05-07T20:58:42.061899Z","steps":["trace[2104427114] 'process raft request' (duration: 113.34945ms)","trace[2104427114] 'compare' (duration: 166.188182ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T20:58:42.062199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.750347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-05-07T20:58:42.062327Z","caller":"traceutil/trace.go:171","msg":"trace[1389068998] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1826; }","duration":"183.933882ms","start":"2026-05-07T20:58:41.878365Z","end":"2026-05-07T20:58:42.062299Z","steps":["trace[1389068998] 'agreement among raft nodes before linearized reading' (duration: 183.642735ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T20:58:42.062748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.085006ms","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-07T20:58:42.062834Z","caller":"traceutil/trace.go:171","msg":"trace[542821565] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1826; }","duration":"238.168699ms","start":"2026-05-07T20:58:41.824621Z","end":"2026-05-07T20:58:42.06279Z","steps":["trace[542821565] 'agreement among raft nodes before linearized reading' (duration: 237.334497ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T20:59:32.132869Z","caller":"traceutil/trace.go:171","msg":"trace[1801425788] transaction","detail":"{read_only:false; response_revision:2056; number_of_response:1; }","duration":"108.587539ms","start":"2026-05-07T20:59:32.024257Z","end":"2026-05-07T20:59:32.132844Z","steps":["trace[1801425788] 'process raft request' (duration: 108.386543ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T21:00:12.108668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.73548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-07T21:00:12.108793Z","caller":"traceutil/trace.go:171","msg":"trace[1124405052] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:2261; }","duration":"103.879863ms","start":"2026-05-07T21:00:12.004892Z","end":"2026-05-07T21:00:12.108772Z","steps":["trace[1124405052] 'count revisions from in-memory index tree' (duration: 103.664307ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T21:00:18.789353Z","caller":"traceutil/trace.go:171","msg":"trace[2117932327] linearizableReadLoop","detail":"{readStateIndex:2389; appliedIndex:2388; }","duration":"168.699248ms","start":"2026-05-07T21:00:18.620629Z","end":"2026-05-07T21:00:18.789328Z","steps":["trace[2117932327] 'read index received' (duration: 168.508233ms)","trace[2117932327] 'applied index is now lower than readState.Index' (duration: 190.075µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T21:00:18.789446Z","caller":"traceutil/trace.go:171","msg":"trace[550503779] transaction","detail":"{read_only:false; response_revision:2298; number_of_response:1; }","duration":"191.878479ms","start":"2026-05-07T21:00:18.597524Z","end":"2026-05-07T21:00:18.789402Z","steps":["trace[550503779] 'process raft request' (duration: 191.680813ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T21:00:18.789623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.967936ms","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":"info","ts":"2026-05-07T21:00:18.789696Z","caller":"traceutil/trace.go:171","msg":"trace[844806255] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2298; }","duration":"169.077619ms","start":"2026-05-07T21:00:18.620599Z","end":"2026-05-07T21:00:18.789677Z","steps":["trace[844806255] 'agreement among raft nodes before linearized reading' (duration: 168.841943ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T21:00:18.789715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.075668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-07T21:00:18.789992Z","caller":"traceutil/trace.go:171","msg":"trace[1349536801] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2298; }","duration":"131.419097ms","start":"2026-05-07T21:00:18.65855Z","end":"2026-05-07T21:00:18.78997Z","steps":["trace[1349536801] 'agreement among raft nodes before linearized reading' (duration: 130.910044ms)"],"step_count":1}