{"level":"warn","ts":"2026-06-02T12:13:23.491754Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-02T12:13:23.491856Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.65: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.65:2380","--initial-cluster=instance=https://199.204.45.65:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.65:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.65:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-02T12:13:23.492007Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-02T12:13:23.49202Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.65:2380"]} {"level":"info","ts":"2026-06-02T12:13:23.492064Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-02T12:13:23.493027Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"]} {"level":"info","ts":"2026-06-02T12:13:23.493126Z","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.65:2380"],"listen-peer-urls":["https://199.204.45.65:2380"],"advertise-client-urls":["https://199.204.45.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.65:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-02T12:13:23.497212Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.824429ms"} {"level":"info","ts":"2026-06-02T12:13:23.50693Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cf8c3a138c9a77a2","cluster-id":"c278183e1f634dff"} {"level":"info","ts":"2026-06-02T12:13:23.507032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=()"} {"level":"info","ts":"2026-06-02T12:13:23.507052Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 0"} {"level":"info","ts":"2026-06-02T12:13:23.507069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cf8c3a138c9a77a2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-02T12:13:23.507079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 1"} {"level":"info","ts":"2026-06-02T12:13:23.507119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"warn","ts":"2026-06-02T12:13:23.513328Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-02T12:13:23.516909Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-02T12:13:23.51787Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-02T12:13:23.520753Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cf8c3a138c9a77a2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-02T12:13:23.521467Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cf8c3a138c9a77a2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-02T12:13:23.52155Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-02T12:13:23.521592Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-02T12:13:23.521601Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-02T12:13:23.52435Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"info","ts":"2026-06-02T12:13:23.524951Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c278183e1f634dff","local-member-id":"cf8c3a138c9a77a2","added-peer-id":"cf8c3a138c9a77a2","added-peer-peer-urls":["https://199.204.45.65:2380"]} {"level":"info","ts":"2026-06-02T12:13:23.52566Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-02T12:13:23.525952Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cf8c3a138c9a77a2","initial-advertise-peer-urls":["https://199.204.45.65:2380"],"listen-peer-urls":["https://199.204.45.65:2380"],"advertise-client-urls":["https://199.204.45.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-02T12:13:23.525992Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-02T12:13:23.526534Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-06-02T12:13:23.52657Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-06-02T12:13:24.008338Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 is starting a new election at term 1"} {"level":"info","ts":"2026-06-02T12:13:24.008398Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-02T12:13:24.00844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgPreVoteResp from cf8c3a138c9a77a2 at term 1"} {"level":"info","ts":"2026-06-02T12:13:24.008458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became candidate at term 2"} {"level":"info","ts":"2026-06-02T12:13:24.00847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgVoteResp from cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-06-02T12:13:24.0085Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became leader at term 2"} {"level":"info","ts":"2026-06-02T12:13:24.008518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cf8c3a138c9a77a2 elected leader cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-06-02T12:13:24.009635Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cf8c3a138c9a77a2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.65:2379]}","request-path":"/0/members/cf8c3a138c9a77a2/attributes","cluster-id":"c278183e1f634dff","publish-timeout":"7s"} {"level":"info","ts":"2026-06-02T12:13:24.009664Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T12:13:24.009871Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-02T12:13:24.010047Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-02T12:13:24.0104Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-02T12:13:24.010476Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-02T12:13:24.013244Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.65:2379"} {"level":"info","ts":"2026-06-02T12:13:24.013325Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-02T12:13:24.013687Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c278183e1f634dff","local-member-id":"cf8c3a138c9a77a2","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T12:13:24.013845Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T12:13:24.013914Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T12:13:30.939532Z","caller":"traceutil/trace.go:171","msg":"trace[538058483] transaction","detail":"{read_only:false; response_revision:274; number_of_response:1; }","duration":"252.703843ms","start":"2026-06-02T12:13:30.686803Z","end":"2026-06-02T12:13:30.939507Z","steps":["trace[538058483] 'process raft request' (duration: 252.587789ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:13:30.93954Z","caller":"traceutil/trace.go:171","msg":"trace[930779578] linearizableReadLoop","detail":"{readStateIndex:285; appliedIndex:284; }","duration":"247.618523ms","start":"2026-06-02T12:13:30.691883Z","end":"2026-06-02T12:13:30.939501Z","steps":["trace[930779578] 'read index received' (duration: 247.604602ms)","trace[930779578] 'applied index is now lower than readState.Index' (duration: 11.82µs)"],"step_count":2} {"level":"warn","ts":"2026-06-02T12:13:30.939761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.928513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T12:13:30.93975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.83886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T12:13:30.939844Z","caller":"traceutil/trace.go:171","msg":"trace[1164173015] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:274; }","duration":"158.030457ms","start":"2026-06-02T12:13:30.781788Z","end":"2026-06-02T12:13:30.939819Z","steps":["trace[1164173015] 'agreement among raft nodes before linearized reading' (duration: 157.923823ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:13:30.939845Z","caller":"traceutil/trace.go:171","msg":"trace[171384241] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:0; response_revision:274; }","duration":"247.980605ms","start":"2026-06-02T12:13:30.691847Z","end":"2026-06-02T12:13:30.939827Z","steps":["trace[171384241] 'agreement among raft nodes before linearized reading' (duration: 247.795759ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:13:30.939987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.117359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T12:13:30.940039Z","caller":"traceutil/trace.go:171","msg":"trace[1359814051] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:274; }","duration":"158.188991ms","start":"2026-06-02T12:13:30.781835Z","end":"2026-06-02T12:13:30.940024Z","steps":["trace[1359814051] 'agreement among raft nodes before linearized reading' (duration: 158.107378ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:13:37.148824Z","caller":"traceutil/trace.go:171","msg":"trace[1580722482] linearizableReadLoop","detail":"{readStateIndex:370; appliedIndex:369; }","duration":"172.401385ms","start":"2026-06-02T12:13:36.976398Z","end":"2026-06-02T12:13:37.148799Z","steps":["trace[1580722482] 'read index received' (duration: 172.198489ms)","trace[1580722482] 'applied index is now lower than readState.Index' (duration: 201.706µs)"],"step_count":2} {"level":"warn","ts":"2026-06-02T12:13:37.149003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.54535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-02T12:13:37.149002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.587511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-02T12:13:37.149057Z","caller":"traceutil/trace.go:171","msg":"trace[423773789] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:357; }","duration":"164.638183ms","start":"2026-06-02T12:13:36.984403Z","end":"2026-06-02T12:13:37.149042Z","steps":["trace[423773789] 'agreement among raft nodes before linearized reading' (duration: 164.52829ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:13:37.149063Z","caller":"traceutil/trace.go:171","msg":"trace[512385328] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:357; }","duration":"172.692054ms","start":"2026-06-02T12:13:36.976357Z","end":"2026-06-02T12:13:37.149049Z","steps":["trace[512385328] 'agreement among raft nodes before linearized reading' (duration: 172.55434ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:13:37.874921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.487428ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T12:13:37.87516Z","caller":"traceutil/trace.go:171","msg":"trace[2120535203] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"725.239087ms","start":"2026-06-02T12:13:37.14988Z","end":"2026-06-02T12:13:37.875119Z","steps":["trace[2120535203] 'process raft request' (duration: 249.990936ms)","trace[2120535203] 'compare' (duration: 474.332123ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:13:37.875239Z","caller":"traceutil/trace.go:171","msg":"trace[1140342350] linearizableReadLoop","detail":"{readStateIndex:373; appliedIndex:370; }","duration":"303.942145ms","start":"2026-06-02T12:13:37.57128Z","end":"2026-06-02T12:13:37.875222Z","steps":["trace[1140342350] 'read index received' (duration: 53.68361ms)","trace[1140342350] 'applied index is now lower than readState.Index' (duration: 250.257625ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:13:37.875271Z","caller":"traceutil/trace.go:171","msg":"trace[1751601011] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"721.900448ms","start":"2026-06-02T12:13:37.153352Z","end":"2026-06-02T12:13:37.875253Z","steps":["trace[1751601011] 'process raft request' (duration: 721.726752ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:13:37.875326Z","caller":"traceutil/trace.go:171","msg":"trace[463842913] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"721.573328ms","start":"2026-06-02T12:13:37.153743Z","end":"2026-06-02T12:13:37.875317Z","steps":["trace[463842913] 'process raft request' (duration: 721.442785ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:13:37.875378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T12:13:37.153333Z","time spent":"721.991981ms","remote":"127.0.0.1:41434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T12:13:37.875367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T12:13:37.149863Z","time spent":"725.392532ms","remote":"127.0.0.1:41160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T12:13:37.875408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T12:13:37.153716Z","time spent":"721.636671ms","remote":"127.0.0.1:41434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T12:13:37.875623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.346607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-02T12:13:37.875661Z","caller":"traceutil/trace.go:171","msg":"trace[836594176] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:360; }","duration":"304.407878ms","start":"2026-06-02T12:13:37.571244Z","end":"2026-06-02T12:13:37.875652Z","steps":["trace[836594176] 'agreement among raft nodes before linearized reading' (duration: 304.194262ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:13:37.875667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.858736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-02T12:13:37.875689Z","caller":"traceutil/trace.go:171","msg":"trace[1924267977] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:360; }","duration":"214.894256ms","start":"2026-06-02T12:13:37.660789Z","end":"2026-06-02T12:13:37.875683Z","steps":["trace[1924267977] 'agreement among raft nodes before linearized reading' (duration: 214.840415ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:13:37.87569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T12:13:37.571229Z","time spent":"304.45502ms","remote":"127.0.0.1:41434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-02T12:13:38.165633Z","caller":"traceutil/trace.go:171","msg":"trace[1715917621] linearizableReadLoop","detail":"{readStateIndex:375; appliedIndex:373; }","duration":"142.049092ms","start":"2026-06-02T12:13:38.023551Z","end":"2026-06-02T12:13:38.1656Z","steps":["trace[1715917621] 'read index received' (duration: 100.671447ms)","trace[1715917621] 'applied index is now lower than readState.Index' (duration: 41.376465ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:13:38.165682Z","caller":"traceutil/trace.go:171","msg":"trace[369452284] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"281.8945ms","start":"2026-06-02T12:13:37.883757Z","end":"2026-06-02T12:13:38.165651Z","steps":["trace[369452284] 'process raft request' (duration: 240.413201ms)","trace[369452284] 'compare' (duration: 41.259942ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:13:38.165695Z","caller":"traceutil/trace.go:171","msg":"trace[550091268] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"280.985833ms","start":"2026-06-02T12:13:37.884684Z","end":"2026-06-02T12:13:38.16567Z","steps":["trace[550091268] 'process raft request' (duration: 280.87064ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:13:38.1658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.208437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6961"} {"level":"info","ts":"2026-06-02T12:13:38.166916Z","caller":"traceutil/trace.go:171","msg":"trace[332920990] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:362; }","duration":"143.370001ms","start":"2026-06-02T12:13:38.023517Z","end":"2026-06-02T12:13:38.166887Z","steps":["trace[332920990] 'agreement among raft nodes before linearized reading' (duration: 142.195536ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:13:59.586662Z","caller":"traceutil/trace.go:171","msg":"trace[1375343235] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"207.190607ms","start":"2026-06-02T12:13:59.379441Z","end":"2026-06-02T12:13:59.586632Z","steps":["trace[1375343235] 'process raft request' (duration: 207.072394ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:13:59.596513Z","caller":"traceutil/trace.go:171","msg":"trace[1146353041] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"215.924013ms","start":"2026-06-02T12:13:59.380568Z","end":"2026-06-02T12:13:59.596492Z","steps":["trace[1146353041] 'process raft request' (duration: 215.707208ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:13:59.596686Z","caller":"traceutil/trace.go:171","msg":"trace[1857527319] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"215.993155ms","start":"2026-06-02T12:13:59.380634Z","end":"2026-06-02T12:13:59.596628Z","steps":["trace[1857527319] 'process raft request' (duration: 215.746129ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:13:59.596922Z","caller":"traceutil/trace.go:171","msg":"trace[170335413] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"209.645727ms","start":"2026-06-02T12:13:59.387261Z","end":"2026-06-02T12:13:59.596907Z","steps":["trace[170335413] 'process raft request' (duration: 209.429612ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:13:59.596788Z","caller":"traceutil/trace.go:171","msg":"trace[583292191] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"209.969266ms","start":"2026-06-02T12:13:59.386807Z","end":"2026-06-02T12:13:59.596776Z","steps":["trace[583292191] 'process raft request' (duration: 209.634138ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:13:59.596906Z","caller":"traceutil/trace.go:171","msg":"trace[985999446] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"209.990016ms","start":"2026-06-02T12:13:59.386864Z","end":"2026-06-02T12:13:59.596854Z","steps":["trace[985999446] 'process raft request' (duration: 209.771511ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:13:59.597081Z","caller":"traceutil/trace.go:171","msg":"trace[2041186742] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"201.607318ms","start":"2026-06-02T12:13:59.395422Z","end":"2026-06-02T12:13:59.597029Z","steps":["trace[2041186742] 'process raft request' (duration: 201.305611ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:13:59.597356Z","caller":"traceutil/trace.go:171","msg":"trace[1260560369] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"200.006728ms","start":"2026-06-02T12:13:59.39734Z","end":"2026-06-02T12:13:59.597347Z","steps":["trace[1260560369] 'process raft request' (duration: 199.584738ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:13:59.597514Z","caller":"traceutil/trace.go:171","msg":"trace[295960720] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"200.022699ms","start":"2026-06-02T12:13:59.397483Z","end":"2026-06-02T12:13:59.597506Z","steps":["trace[295960720] 'process raft request' (duration: 199.803464ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:13:59.598127Z","caller":"traceutil/trace.go:171","msg":"trace[2078791220] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"181.024708ms","start":"2026-06-02T12:13:59.417093Z","end":"2026-06-02T12:13:59.598117Z","steps":["trace[2078791220] 'process raft request' (duration: 180.258979ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:13:59.598199Z","caller":"traceutil/trace.go:171","msg":"trace[270950542] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"159.274788ms","start":"2026-06-02T12:13:59.43885Z","end":"2026-06-02T12:13:59.598125Z","steps":["trace[270950542] 'process raft request' (duration: 158.655773ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:14:05.508838Z","caller":"traceutil/trace.go:171","msg":"trace[1218774488] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"177.976856ms","start":"2026-06-02T12:14:05.330729Z","end":"2026-06-02T12:14:05.508706Z","steps":["trace[1218774488] 'process raft request' (duration: 166.502673ms)","trace[1218774488] 'compare' (duration: 10.983821ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:14:06.089332Z","caller":"traceutil/trace.go:171","msg":"trace[1062640505] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"377.739814ms","start":"2026-06-02T12:14:05.711497Z","end":"2026-06-02T12:14:06.089237Z","steps":["trace[1062640505] 'process raft request' (duration: 377.286263ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:14:06.090452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T12:14:05.711481Z","time spent":"378.711937ms","remote":"127.0.0.1:41336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T12:14:06.589284Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620626944779139109,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-02T12:14:06.774126Z","caller":"traceutil/trace.go:171","msg":"trace[1055771672] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"716.140943ms","start":"2026-06-02T12:14:06.057963Z","end":"2026-06-02T12:14:06.774104Z","steps":["trace[1055771672] 'process raft request' (duration: 714.383971ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:14:06.774267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T12:14:06.057927Z","time spent":"716.264946ms","remote":"127.0.0.1:41234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T12:14:06.797708Z","caller":"traceutil/trace.go:171","msg":"trace[1244723820] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:614; }","duration":"708.702588ms","start":"2026-06-02T12:14:06.088981Z","end":"2026-06-02T12:14:06.797683Z","steps":["trace[1244723820] 'read index received' (duration: 683.218657ms)","trace[1244723820] 'applied index is now lower than readState.Index' (duration: 25.482911ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T12:14:06.79796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.418766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-02T12:14:06.798Z","caller":"traceutil/trace.go:171","msg":"trace[1257233978] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:593; }","duration":"474.502338ms","start":"2026-06-02T12:14:06.323484Z","end":"2026-06-02T12:14:06.797987Z","steps":["trace[1257233978] 'agreement among raft nodes before linearized reading' (duration: 474.376085ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:14:06.798035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T12:14:06.323464Z","time spent":"474.560739ms","remote":"127.0.0.1:41434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-02T12:14:06.798043Z","caller":"traceutil/trace.go:171","msg":"trace[815539326] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"704.317774ms","start":"2026-06-02T12:14:06.0937Z","end":"2026-06-02T12:14:06.798018Z","steps":["trace[815539326] 'process raft request' (duration: 703.790752ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:14:06.798078Z","caller":"traceutil/trace.go:171","msg":"trace[825068651] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"518.072655ms","start":"2026-06-02T12:14:06.279991Z","end":"2026-06-02T12:14:06.798063Z","steps":["trace[825068651] 'process raft request' (duration: 517.634534ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:14:06.798171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.093911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T12:14:06.798174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T12:14:06.093675Z","time spent":"704.429276ms","remote":"127.0.0.1:41434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T12:14:06.798189Z","caller":"traceutil/trace.go:171","msg":"trace[778515240] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:593; }","duration":"377.142441ms","start":"2026-06-02T12:14:06.421041Z","end":"2026-06-02T12:14:06.798183Z","steps":["trace[778515240] 'agreement among raft nodes before linearized reading' (duration: 377.114261ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:14:06.798205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T12:14:06.42102Z","time spent":"377.181783ms","remote":"127.0.0.1:41140","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-02T12:14:06.798191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T12:14:06.279967Z","time spent":"518.148867ms","remote":"127.0.0.1:41434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T12:14:06.798302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.406127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-02T12:14:06.798317Z","caller":"traceutil/trace.go:171","msg":"trace[600156556] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:593; }","duration":"469.420917ms","start":"2026-06-02T12:14:06.328892Z","end":"2026-06-02T12:14:06.798313Z","steps":["trace[600156556] 'agreement among raft nodes before linearized reading' (duration: 469.378776ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:14:06.798329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T12:14:06.32884Z","time spent":"469.485059ms","remote":"127.0.0.1:41434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-02T12:14:06.798427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"785.470567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-02T12:14:06.798441Z","caller":"traceutil/trace.go:171","msg":"trace[239031681] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:593; }","duration":"785.520808ms","start":"2026-06-02T12:14:06.012916Z","end":"2026-06-02T12:14:06.798437Z","steps":["trace[239031681] 'agreement among raft nodes before linearized reading' (duration: 785.479387ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:14:06.798453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T12:14:06.012894Z","time spent":"785.555419ms","remote":"127.0.0.1:41434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-02T12:14:07.670836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.223435ms","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-06-02T12:14:07.671003Z","caller":"traceutil/trace.go:171","msg":"trace[681081248] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:594; }","duration":"281.383159ms","start":"2026-06-02T12:14:07.389569Z","end":"2026-06-02T12:14:07.670952Z","steps":["trace[681081248] 'range keys from in-memory index tree' (duration: 281.201264ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:14:07.671823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.842852ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T12:14:07.67216Z","caller":"traceutil/trace.go:171","msg":"trace[2088579856] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"868.631531ms","start":"2026-06-02T12:14:06.803496Z","end":"2026-06-02T12:14:07.672128Z","steps":["trace[2088579856] 'process raft request' (duration: 70.100272ms)","trace[2088579856] 'compare' (duration: 797.346611ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T12:14:07.6723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T12:14:06.803486Z","time spent":"868.743754ms","remote":"127.0.0.1:41434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T12:14:07.672446Z","caller":"traceutil/trace.go:171","msg":"trace[1798349268] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"845.843803ms","start":"2026-06-02T12:14:06.82656Z","end":"2026-06-02T12:14:07.672404Z","steps":["trace[1798349268] 'process raft request' (duration: 845.602207ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:14:07.672555Z","caller":"traceutil/trace.go:171","msg":"trace[7287562] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"868.735943ms","start":"2026-06-02T12:14:06.803503Z","end":"2026-06-02T12:14:07.672239Z","steps":["trace[7287562] 'process raft request' (duration: 868.527508ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:14:07.672604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T12:14:06.826544Z","time spent":"846.014068ms","remote":"127.0.0.1:41388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T12:14:07.67272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T12:14:06.803483Z","time spent":"869.142533ms","remote":"127.0.0.1:41434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T12:14:07.673167Z","caller":"traceutil/trace.go:171","msg":"trace[1531017974] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:618; }","duration":"698.249785ms","start":"2026-06-02T12:14:06.974901Z","end":"2026-06-02T12:14:07.67315Z","steps":["trace[1531017974] 'read index received' (duration: 36.751µs)","trace[1531017974] 'applied index is now lower than readState.Index' (duration: 698.211324ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T12:14:07.673497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.592482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.65\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-02T12:14:07.673672Z","caller":"traceutil/trace.go:171","msg":"trace[2010535999] range","detail":"{range_begin:/registry/masterleases/199.204.45.65; range_end:; response_count:1; response_revision:597; }","duration":"698.791896ms","start":"2026-06-02T12:14:06.974862Z","end":"2026-06-02T12:14:07.673654Z","steps":["trace[2010535999] 'agreement among raft nodes before linearized reading' (duration: 698.542431ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:14:07.673771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T12:14:06.974844Z","time spent":"698.90987ms","remote":"127.0.0.1:41160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.65\" "} {"level":"info","ts":"2026-06-02T12:14:07.91662Z","caller":"traceutil/trace.go:171","msg":"trace[542978963] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:622; }","duration":"147.396401ms","start":"2026-06-02T12:14:07.769208Z","end":"2026-06-02T12:14:07.916604Z","steps":["trace[542978963] 'read index received' (duration: 131.119739ms)","trace[542978963] 'applied index is now lower than readState.Index' (duration: 16.274702ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T12:14:07.916737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.518953ms","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-06-02T12:14:07.916763Z","caller":"traceutil/trace.go:171","msg":"trace[474696282] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:598; }","duration":"147.592085ms","start":"2026-06-02T12:14:07.769164Z","end":"2026-06-02T12:14:07.916756Z","steps":["trace[474696282] 'agreement among raft nodes before linearized reading' (duration: 147.509363ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:14:07.916795Z","caller":"traceutil/trace.go:171","msg":"trace[1702978434] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"149.953211ms","start":"2026-06-02T12:14:07.766771Z","end":"2026-06-02T12:14:07.916724Z","steps":["trace[1702978434] 'process raft request' (duration: 133.606337ms)","trace[1702978434] 'compare' (duration: 16.136809ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:14:08.984528Z","caller":"traceutil/trace.go:171","msg":"trace[1535896273] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"164.517055ms","start":"2026-06-02T12:14:08.819751Z","end":"2026-06-02T12:14:08.984268Z","steps":["trace[1535896273] 'process raft request' (duration: 163.748247ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:14:17.278322Z","caller":"traceutil/trace.go:171","msg":"trace[994714903] linearizableReadLoop","detail":"{readStateIndex:734; appliedIndex:733; }","duration":"221.003523ms","start":"2026-06-02T12:14:17.05729Z","end":"2026-06-02T12:14:17.278294Z","steps":["trace[994714903] 'read index received' (duration: 200.499514ms)","trace[994714903] 'applied index is now lower than readState.Index' (duration: 20.502409ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T12:14:17.278498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.197277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-06-02T12:14:17.27849Z","caller":"traceutil/trace.go:171","msg":"trace[1947556419] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"236.236106ms","start":"2026-06-02T12:14:17.042145Z","end":"2026-06-02T12:14:17.278381Z","steps":["trace[1947556419] 'process raft request' (duration: 215.652225ms)","trace[1947556419] 'compare' (duration: 20.378476ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:14:17.278547Z","caller":"traceutil/trace.go:171","msg":"trace[525842757] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:704; }","duration":"221.294119ms","start":"2026-06-02T12:14:17.05724Z","end":"2026-06-02T12:14:17.278534Z","steps":["trace[525842757] 'agreement among raft nodes before linearized reading' (duration: 221.181127ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:14:30.9548Z","caller":"traceutil/trace.go:171","msg":"trace[747935629] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"112.446041ms","start":"2026-06-02T12:14:30.842334Z","end":"2026-06-02T12:14:30.95478Z","steps":["trace[747935629] 'process raft request' (duration: 112.290678ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:14:35.735403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.160338ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T12:14:35.7355Z","caller":"traceutil/trace.go:171","msg":"trace[840824955] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"258.501224ms","start":"2026-06-02T12:14:35.476985Z","end":"2026-06-02T12:14:35.735486Z","steps":["trace[840824955] 'process raft request' (duration: 81.187823ms)","trace[840824955] 'compare' (duration: 177.021805ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:14:35.746298Z","caller":"traceutil/trace.go:171","msg":"trace[383496219] linearizableReadLoop","detail":"{readStateIndex:857; appliedIndex:856; }","duration":"161.167242ms","start":"2026-06-02T12:14:35.585101Z","end":"2026-06-02T12:14:35.746268Z","steps":["trace[383496219] 'read index received' (duration: 160.952688ms)","trace[383496219] 'applied index is now lower than readState.Index' (duration: 213.214µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:14:35.746517Z","caller":"traceutil/trace.go:171","msg":"trace[1618555725] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"184.600624ms","start":"2026-06-02T12:14:35.561854Z","end":"2026-06-02T12:14:35.746455Z","steps":["trace[1618555725] 'process raft request' (duration: 184.286968ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:14:35.747897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.779624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050256"} {"level":"info","ts":"2026-06-02T12:14:35.747971Z","caller":"traceutil/trace.go:171","msg":"trace[687555680] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:823; }","duration":"162.918586ms","start":"2026-06-02T12:14:35.585033Z","end":"2026-06-02T12:14:35.747952Z","steps":["trace[687555680] 'agreement among raft nodes before linearized reading' (duration: 161.360945ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:14:35.973904Z","caller":"traceutil/trace.go:171","msg":"trace[1678987125] transaction","detail":"{read_only:false; response_revision:824; number_of_response:1; }","duration":"165.360095ms","start":"2026-06-02T12:14:35.808514Z","end":"2026-06-02T12:14:35.973874Z","steps":["trace[1678987125] 'process raft request' (duration: 112.98386ms)","trace[1678987125] 'compare' (duration: 52.014887ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:14:35.973909Z","caller":"traceutil/trace.go:171","msg":"trace[1168695413] transaction","detail":"{read_only:false; response_revision:825; number_of_response:1; }","duration":"161.56384ms","start":"2026-06-02T12:14:35.812322Z","end":"2026-06-02T12:14:35.973886Z","steps":["trace[1168695413] 'process raft request' (duration: 161.380506ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:14:36.884213Z","caller":"traceutil/trace.go:171","msg":"trace[899697676] linearizableReadLoop","detail":"{readStateIndex:870; appliedIndex:868; }","duration":"178.625068ms","start":"2026-06-02T12:14:36.705562Z","end":"2026-06-02T12:14:36.884188Z","steps":["trace[899697676] 'read index received' (duration: 86.0677ms)","trace[899697676] 'applied index is now lower than readState.Index' (duration: 92.556408ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:14:36.884313Z","caller":"traceutil/trace.go:171","msg":"trace[1087481080] transaction","detail":"{read_only:false; response_revision:836; number_of_response:1; }","duration":"184.530283ms","start":"2026-06-02T12:14:36.699743Z","end":"2026-06-02T12:14:36.884273Z","steps":["trace[1087481080] 'process raft request' (duration: 184.382901ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:14:36.884597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.962427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-02T12:14:36.884613Z","caller":"traceutil/trace.go:171","msg":"trace[792365542] transaction","detail":"{read_only:false; response_revision:835; number_of_response:1; }","duration":"184.902802ms","start":"2026-06-02T12:14:36.699679Z","end":"2026-06-02T12:14:36.884582Z","steps":["trace[792365542] 'process raft request' (duration: 91.937676ms)","trace[792365542] 'compare' (duration: 92.325943ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:14:36.884657Z","caller":"traceutil/trace.go:171","msg":"trace[1378119950] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:836; }","duration":"144.081449ms","start":"2026-06-02T12:14:36.740561Z","end":"2026-06-02T12:14:36.884642Z","steps":["trace[1378119950] 'agreement among raft nodes before linearized reading' (duration: 143.967677ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:14:36.884638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.047296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/\" range_end:\"/registry/serviceaccounts/envoy-gateway-system0\" limit:10000 ","response":"range_response_count:3 size:1862"} {"level":"warn","ts":"2026-06-02T12:14:36.884821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.250222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/eg\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T12:14:36.884955Z","caller":"traceutil/trace.go:171","msg":"trace[611571823] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/eg; range_end:; response_count:0; response_revision:836; }","duration":"143.428767ms","start":"2026-06-02T12:14:36.741509Z","end":"2026-06-02T12:14:36.884938Z","steps":["trace[611571823] 'agreement among raft nodes before linearized reading' (duration: 143.226563ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:14:36.884882Z","caller":"traceutil/trace.go:171","msg":"trace[2017793023] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/; range_end:/registry/serviceaccounts/envoy-gateway-system0; response_count:3; response_revision:836; }","duration":"179.336042ms","start":"2026-06-02T12:14:36.705521Z","end":"2026-06-02T12:14:36.884857Z","steps":["trace[2017793023] 'agreement among raft nodes before linearized reading' (duration: 178.819412ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:14:37.108005Z","caller":"traceutil/trace.go:171","msg":"trace[890251801] transaction","detail":"{read_only:false; response_revision:837; number_of_response:1; }","duration":"217.138644ms","start":"2026-06-02T12:14:36.89083Z","end":"2026-06-02T12:14:37.107969Z","steps":["trace[890251801] 'process raft request' (duration: 155.855637ms)","trace[890251801] 'compare' (duration: 61.116164ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:14:37.157378Z","caller":"traceutil/trace.go:171","msg":"trace[2085879609] linearizableReadLoop","detail":"{readStateIndex:872; appliedIndex:870; }","duration":"264.130571ms","start":"2026-06-02T12:14:36.893226Z","end":"2026-06-02T12:14:37.157356Z","steps":["trace[2085879609] 'read index received' (duration: 153.474409ms)","trace[2085879609] 'applied index is now lower than readState.Index' (duration: 110.655282ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:14:37.157504Z","caller":"traceutil/trace.go:171","msg":"trace[1151820971] transaction","detail":"{read_only:false; response_revision:838; number_of_response:1; }","duration":"264.56408ms","start":"2026-06-02T12:14:36.892911Z","end":"2026-06-02T12:14:37.157475Z","steps":["trace[1151820971] 'process raft request' (duration: 264.335416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:14:37.157585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.340186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/envoy-gateway-system/\" range_end:\"/registry/deployments/envoy-gateway-system0\" limit:10000 ","response":"range_response_count:1 size:5616"} {"level":"info","ts":"2026-06-02T12:14:37.157628Z","caller":"traceutil/trace.go:171","msg":"trace[780689534] range","detail":"{range_begin:/registry/deployments/envoy-gateway-system/; range_end:/registry/deployments/envoy-gateway-system0; response_count:1; response_revision:838; }","duration":"264.436257ms","start":"2026-06-02T12:14:36.893179Z","end":"2026-06-02T12:14:37.157616Z","steps":["trace[780689534] 'agreement among raft nodes before linearized reading' (duration: 264.282714ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:14:37.167734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.836681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-02T12:14:37.167862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.986401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-02T12:14:37.167922Z","caller":"traceutil/trace.go:171","msg":"trace[661109405] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:839; }","duration":"172.079503ms","start":"2026-06-02T12:14:36.995824Z","end":"2026-06-02T12:14:37.167904Z","steps":["trace[661109405] 'agreement among raft nodes before linearized reading' (duration: 171.933761ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:14:37.167884Z","caller":"traceutil/trace.go:171","msg":"trace[1265224948] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:839; }","duration":"163.015165ms","start":"2026-06-02T12:14:37.004838Z","end":"2026-06-02T12:14:37.167853Z","steps":["trace[1265224948] 'agreement among raft nodes before linearized reading' (duration: 162.786211ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:14:37.168134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.920083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.65\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-02T12:14:37.168173Z","caller":"traceutil/trace.go:171","msg":"trace[1793774586] range","detail":"{range_begin:/registry/masterleases/199.204.45.65; range_end:; response_count:1; response_revision:839; }","duration":"191.987543ms","start":"2026-06-02T12:14:36.976176Z","end":"2026-06-02T12:14:37.168163Z","steps":["trace[1793774586] 'agreement among raft nodes before linearized reading' (duration: 191.774319ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:14:37.332656Z","caller":"traceutil/trace.go:171","msg":"trace[465854844] transaction","detail":"{read_only:false; response_revision:840; number_of_response:1; }","duration":"168.94461ms","start":"2026-06-02T12:14:37.16369Z","end":"2026-06-02T12:14:37.332635Z","steps":["trace[465854844] 'process raft request' (duration: 168.760657ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:14:37.332834Z","caller":"traceutil/trace.go:171","msg":"trace[143390342] linearizableReadLoop","detail":"{readStateIndex:875; appliedIndex:873; }","duration":"165.218968ms","start":"2026-06-02T12:14:37.167602Z","end":"2026-06-02T12:14:37.332821Z","steps":["trace[143390342] 'read index received' (duration: 164.852631ms)","trace[143390342] 'applied index is now lower than readState.Index' (duration: 365.557µs)"],"step_count":2} {"level":"warn","ts":"2026-06-02T12:14:37.332967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.791446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/envoy-gateway-system/\" range_end:\"/registry/daemonsets/envoy-gateway-system0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T12:14:37.333007Z","caller":"traceutil/trace.go:171","msg":"trace[172571331] range","detail":"{range_begin:/registry/daemonsets/envoy-gateway-system/; range_end:/registry/daemonsets/envoy-gateway-system0; response_count:0; response_revision:841; }","duration":"171.870098ms","start":"2026-06-02T12:14:37.161125Z","end":"2026-06-02T12:14:37.332995Z","steps":["trace[172571331] 'agreement among raft nodes before linearized reading' (duration: 171.740525ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:14:37.333146Z","caller":"traceutil/trace.go:171","msg":"trace[879661950] transaction","detail":"{read_only:false; response_revision:841; number_of_response:1; }","duration":"169.288777ms","start":"2026-06-02T12:14:37.163835Z","end":"2026-06-02T12:14:37.333124Z","steps":["trace[879661950] 'process raft request' (duration: 168.748146ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:14:37.366876Z","caller":"traceutil/trace.go:171","msg":"trace[1794406953] transaction","detail":"{read_only:false; response_revision:842; number_of_response:1; }","duration":"195.659642ms","start":"2026-06-02T12:14:37.171187Z","end":"2026-06-02T12:14:37.366846Z","steps":["trace[1794406953] 'process raft request' (duration: 195.458308ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:14:37.536934Z","caller":"traceutil/trace.go:171","msg":"trace[1295287598] linearizableReadLoop","detail":"{readStateIndex:879; appliedIndex:878; }","duration":"137.888334ms","start":"2026-06-02T12:14:37.399025Z","end":"2026-06-02T12:14:37.536914Z","steps":["trace[1295287598] 'read index received' (duration: 137.850244ms)","trace[1295287598] 'applied index is now lower than readState.Index' (duration: 36.98µs)"],"step_count":2} {"level":"warn","ts":"2026-06-02T12:14:37.537071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.028527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-02T12:14:37.537019Z","caller":"traceutil/trace.go:171","msg":"trace[211441318] transaction","detail":"{read_only:false; response_revision:844; number_of_response:1; }","duration":"139.541526ms","start":"2026-06-02T12:14:37.397446Z","end":"2026-06-02T12:14:37.536988Z","steps":["trace[211441318] 'process raft request' (duration: 139.341232ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:14:37.537108Z","caller":"traceutil/trace.go:171","msg":"trace[131241436] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:844; }","duration":"138.137499ms","start":"2026-06-02T12:14:37.398961Z","end":"2026-06-02T12:14:37.537098Z","steps":["trace[131241436] 'agreement among raft nodes before linearized reading' (duration: 138.057017ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:14:37.561381Z","caller":"traceutil/trace.go:171","msg":"trace[768710332] transaction","detail":"{read_only:false; response_revision:845; number_of_response:1; }","duration":"153.313975ms","start":"2026-06-02T12:14:37.408055Z","end":"2026-06-02T12:14:37.561369Z","steps":["trace[768710332] 'process raft request' (duration: 153.242664ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:14:37.561538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.068096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T12:14:37.561712Z","caller":"traceutil/trace.go:171","msg":"trace[1778695229] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:845; }","duration":"141.2729ms","start":"2026-06-02T12:14:37.420413Z","end":"2026-06-02T12:14:37.561686Z","steps":["trace[1778695229] 'agreement among raft nodes before linearized reading' (duration: 140.974864ms)"],"step_count":1}