{"level":"warn","ts":"2026-05-27T13:45:37.202392Z","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-27T13:45:37.202964Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.109: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.109:2380","--initial-cluster=instance=https://199.204.45.109:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.109:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.109: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-27T13:45:37.203071Z","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-27T13:45:37.203094Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-05-27T13:45:37.203134Z","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-27T13:45:37.204007Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"]} {"level":"info","ts":"2026-05-27T13:45:37.204192Z","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.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.109: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-27T13:45:37.209231Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.713792ms"} {"level":"info","ts":"2026-05-27T13:45:37.217618Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d71a1778b31d4ce","cluster-id":"aaca35652fabf9b2"} {"level":"info","ts":"2026-05-27T13:45:37.217701Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=()"} {"level":"info","ts":"2026-05-27T13:45:37.217732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 0"} {"level":"info","ts":"2026-05-27T13:45:37.217745Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d71a1778b31d4ce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-27T13:45:37.217764Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 1"} {"level":"info","ts":"2026-05-27T13:45:37.217894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"warn","ts":"2026-05-27T13:45:37.224333Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-27T13:45:37.225659Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-27T13:45:37.226876Z","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-27T13:45:37.229004Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d71a1778b31d4ce","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-27T13:45:37.229176Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d71a1778b31d4ce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-27T13:45:37.229213Z","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-27T13:45:37.229309Z","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-27T13:45:37.229329Z","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-27T13:45:37.230349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"info","ts":"2026-05-27T13:45:37.230762Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","added-peer-id":"d71a1778b31d4ce","added-peer-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-05-27T13:45:37.235091Z","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-27T13:45:37.235405Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d71a1778b31d4ce","initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-27T13:45:37.235451Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-27T13:45:37.235721Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-05-27T13:45:37.235756Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-05-27T13:45:37.718721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce is starting a new election at term 1"} {"level":"info","ts":"2026-05-27T13:45:37.7188Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became pre-candidate at term 1"} {"level":"info","ts":"2026-05-27T13:45:37.718828Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgPreVoteResp from d71a1778b31d4ce at term 1"} {"level":"info","ts":"2026-05-27T13:45:37.718849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became candidate at term 2"} {"level":"info","ts":"2026-05-27T13:45:37.718866Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgVoteResp from d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-05-27T13:45:37.718887Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became leader at term 2"} {"level":"info","ts":"2026-05-27T13:45:37.718905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d71a1778b31d4ce elected leader d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-05-27T13:45:37.719877Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d71a1778b31d4ce","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.109:2379]}","request-path":"/0/members/d71a1778b31d4ce/attributes","cluster-id":"aaca35652fabf9b2","publish-timeout":"7s"} {"level":"info","ts":"2026-05-27T13:45:37.719883Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T13:45:37.719962Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T13:45:37.720132Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-27T13:45:37.720172Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-27T13:45:37.723256Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.109:2379"} {"level":"info","ts":"2026-05-27T13:45:37.723481Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-27T13:45:37.73036Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:45:37.736464Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:45:37.736562Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:45:37.73659Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:45:40.778153Z","caller":"traceutil/trace.go:171","msg":"trace[1926666244] transaction","detail":"{read_only:false; response_revision:152; number_of_response:1; }","duration":"269.303299ms","start":"2026-05-27T13:45:40.508825Z","end":"2026-05-27T13:45:40.778129Z","steps":["trace[1926666244] 'process raft request' (duration: 269.256408ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:40.778242Z","caller":"traceutil/trace.go:171","msg":"trace[132322743] transaction","detail":"{read_only:false; response_revision:151; number_of_response:1; }","duration":"270.914415ms","start":"2026-05-27T13:45:40.507293Z","end":"2026-05-27T13:45:40.778207Z","steps":["trace[132322743] 'process raft request' (duration: 264.052269ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:41.235933Z","caller":"traceutil/trace.go:171","msg":"trace[20730918] transaction","detail":"{read_only:false; response_revision:213; number_of_response:1; }","duration":"215.327957ms","start":"2026-05-27T13:45:41.020579Z","end":"2026-05-27T13:45:41.235907Z","steps":["trace[20730918] 'process raft request' (duration: 120.93499ms)","trace[20730918] 'compare' (duration: 94.252945ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:45:49.133973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.428286ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:45:49.134078Z","caller":"traceutil/trace.go:171","msg":"trace[1295332311] linearizableReadLoop","detail":"{readStateIndex:360; appliedIndex:359; }","duration":"770.62398ms","start":"2026-05-27T13:45:48.363438Z","end":"2026-05-27T13:45:49.134062Z","steps":["trace[1295332311] 'read index received' (duration: 426.027726ms)","trace[1295332311] 'applied index is now lower than readState.Index' (duration: 344.594724ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:45:49.134153Z","caller":"traceutil/trace.go:171","msg":"trace[1786721762] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"810.338115ms","start":"2026-05-27T13:45:48.323805Z","end":"2026-05-27T13:45:49.134143Z","steps":["trace[1786721762] 'process raft request' (duration: 465.611769ms)","trace[1786721762] 'compare' (duration: 342.678724ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:45:49.134216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:48.323796Z","time spent":"810.389606ms","remote":"127.0.0.1:52164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3642,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:45:49.134457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.018356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"warn","ts":"2026-05-27T13:45:49.134588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.733013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-05-27T13:45:49.134632Z","caller":"traceutil/trace.go:171","msg":"trace[1703166365] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:346; }","duration":"470.799813ms","start":"2026-05-27T13:45:48.66382Z","end":"2026-05-27T13:45:49.13462Z","steps":["trace[1703166365] 'agreement among raft nodes before linearized reading' (duration: 470.721392ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:49.13461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"720.215485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"warn","ts":"2026-05-27T13:45:49.134666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:48.663808Z","time spent":"470.850324ms","remote":"127.0.0.1:51864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":257,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"info","ts":"2026-05-27T13:45:49.134704Z","caller":"traceutil/trace.go:171","msg":"trace[2140764401] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:346; }","duration":"720.352076ms","start":"2026-05-27T13:45:48.41433Z","end":"2026-05-27T13:45:49.134683Z","steps":["trace[2140764401] 'agreement among raft nodes before linearized reading' (duration: 720.186614ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:49.134753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:48.414313Z","time spent":"720.431288ms","remote":"127.0.0.1:51864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-05-27T13:45:49.13485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.250758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"} {"level":"info","ts":"2026-05-27T13:45:49.134887Z","caller":"traceutil/trace.go:171","msg":"trace[1392774486] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:346; }","duration":"125.286608ms","start":"2026-05-27T13:45:49.00959Z","end":"2026-05-27T13:45:49.134876Z","steps":["trace[1392774486] 'agreement among raft nodes before linearized reading' (duration: 125.226437ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:49.134999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.057226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"warn","ts":"2026-05-27T13:45:49.135037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.030838ms","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-27T13:45:49.135042Z","caller":"traceutil/trace.go:171","msg":"trace[331942628] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:346; }","duration":"521.129597ms","start":"2026-05-27T13:45:48.613901Z","end":"2026-05-27T13:45:49.135031Z","steps":["trace[331942628] 'agreement among raft nodes before linearized reading' (duration: 521.042025ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:49.135067Z","caller":"traceutil/trace.go:171","msg":"trace[1255130049] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:346; }","duration":"138.093569ms","start":"2026-05-27T13:45:48.996964Z","end":"2026-05-27T13:45:49.135057Z","steps":["trace[1255130049] 'agreement among raft nodes before linearized reading' (duration: 138.043218ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:49.135117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"671.145701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"warn","ts":"2026-05-27T13:45:49.135064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.641951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-05-27T13:45:49.135151Z","caller":"traceutil/trace.go:171","msg":"trace[336308829] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:346; }","duration":"671.210412ms","start":"2026-05-27T13:45:48.463931Z","end":"2026-05-27T13:45:49.135141Z","steps":["trace[336308829] 'agreement among raft nodes before linearized reading' (duration: 671.159961ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:49.135177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:48.463911Z","time spent":"671.260684ms","remote":"127.0.0.1:51864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":241,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "} {"level":"warn","ts":"2026-05-27T13:45:49.135212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.378287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:45:49.135246Z","caller":"traceutil/trace.go:171","msg":"trace[1077527061] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:346; }","duration":"404.437518ms","start":"2026-05-27T13:45:48.730801Z","end":"2026-05-27T13:45:49.135238Z","steps":["trace[1077527061] 'agreement among raft nodes before linearized reading' (duration: 404.390467ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:49.135172Z","caller":"traceutil/trace.go:171","msg":"trace[627788141] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:346; }","duration":"621.807704ms","start":"2026-05-27T13:45:48.51335Z","end":"2026-05-27T13:45:49.135157Z","steps":["trace[627788141] 'agreement among raft nodes before linearized reading' (duration: 621.60033ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:49.135318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.000835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-27T13:45:49.13535Z","caller":"traceutil/trace.go:171","msg":"trace[1513048202] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:346; }","duration":"422.028695ms","start":"2026-05-27T13:45:48.713311Z","end":"2026-05-27T13:45:49.13534Z","steps":["trace[1513048202] 'agreement among raft nodes before linearized reading' (duration: 421.983174ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:49.13538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:48.713277Z","time spent":"422.096467ms","remote":"127.0.0.1:51864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"warn","ts":"2026-05-27T13:45:49.135393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:48.513325Z","time spent":"621.977598ms","remote":"127.0.0.1:51864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":218,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"warn","ts":"2026-05-27T13:45:49.135398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.059003ms","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":"warn","ts":"2026-05-27T13:45:49.135278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:48.73079Z","time spent":"404.482158ms","remote":"127.0.0.1:51706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-27T13:45:49.135596Z","caller":"traceutil/trace.go:171","msg":"trace[912288493] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:346; }","duration":"571.330078ms","start":"2026-05-27T13:45:48.564255Z","end":"2026-05-27T13:45:49.135585Z","steps":["trace[912288493] 'agreement among raft nodes before linearized reading' (duration: 571.070484ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:49.135639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:48.564235Z","time spent":"571.394278ms","remote":"127.0.0.1:51864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "} {"level":"warn","ts":"2026-05-27T13:45:49.135071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:48.613887Z","time spent":"521.177687ms","remote":"127.0.0.1:51864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":220,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "} {"level":"info","ts":"2026-05-27T13:45:49.13579Z","caller":"traceutil/trace.go:171","msg":"trace[1282142238] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:346; }","duration":"771.108017ms","start":"2026-05-27T13:45:48.363385Z","end":"2026-05-27T13:45:49.134493Z","steps":["trace[1282142238] 'agreement among raft nodes before linearized reading' (duration: 770.991996ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:49.135843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:48.363361Z","time spent":"772.470808ms","remote":"127.0.0.1:51864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":237,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "} {"level":"warn","ts":"2026-05-27T13:45:49.645706Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367957987935538,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T13:45:50.943704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.24634682s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:45:50.944126Z","caller":"traceutil/trace.go:171","msg":"trace[878484367] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"1.801995097s","start":"2026-05-27T13:45:49.142101Z","end":"2026-05-27T13:45:50.944096Z","steps":["trace[878484367] 'process raft request' (duration: 555.061469ms)","trace[878484367] 'compare' (duration: 1.245382695s)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:45:50.9455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:49.142089Z","time spent":"1.803370939s","remote":"127.0.0.1:51928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:45:50.944146Z","caller":"traceutil/trace.go:171","msg":"trace[774763791] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"1.801790124s","start":"2026-05-27T13:45:49.142329Z","end":"2026-05-27T13:45:50.944119Z","steps":["trace[774763791] 'process raft request' (duration: 1.801677731s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:50.945622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:49.142322Z","time spent":"1.803266607s","remote":"127.0.0.1:51766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":680,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:45:50.944204Z","caller":"traceutil/trace.go:171","msg":"trace[556866383] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"1.799665081s","start":"2026-05-27T13:45:49.144531Z","end":"2026-05-27T13:45:50.944196Z","steps":["trace[556866383] 'process raft request' (duration: 1.79959806s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:50.945774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:49.144513Z","time spent":"1.801198305s","remote":"127.0.0.1:52166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2150,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:45:50.944234Z","caller":"traceutil/trace.go:171","msg":"trace[111386498] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"1.799818733s","start":"2026-05-27T13:45:49.14441Z","end":"2026-05-27T13:45:50.944228Z","steps":["trace[111386498] 'process raft request' (duration: 1.79966827s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:50.945969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:49.14439Z","time spent":"1.801547431s","remote":"127.0.0.1:51776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1723,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:45:50.944281Z","caller":"traceutil/trace.go:171","msg":"trace[883504209] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"1.799506819s","start":"2026-05-27T13:45:49.144767Z","end":"2026-05-27T13:45:50.944274Z","steps":["trace[883504209] 'process raft request' (duration: 1.799438388s)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:50.944306Z","caller":"traceutil/trace.go:171","msg":"trace[1299927297] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"1.79955305s","start":"2026-05-27T13:45:49.144746Z","end":"2026-05-27T13:45:50.944299Z","steps":["trace[1299927297] 'process raft request' (duration: 1.799428718s)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:50.944335Z","caller":"traceutil/trace.go:171","msg":"trace[828938525] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"1.799299775s","start":"2026-05-27T13:45:49.145029Z","end":"2026-05-27T13:45:50.944329Z","steps":["trace[828938525] 'process raft request' (duration: 1.799196473s)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:50.94435Z","caller":"traceutil/trace.go:171","msg":"trace[993761038] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"1.799760553s","start":"2026-05-27T13:45:49.14458Z","end":"2026-05-27T13:45:50.94434Z","steps":["trace[993761038] 'process raft request' (duration: 1.79957306s)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:50.94495Z","caller":"traceutil/trace.go:171","msg":"trace[1824935090] linearizableReadLoop","detail":"{readStateIndex:376; appliedIndex:360; }","duration":"1.80023653s","start":"2026-05-27T13:45:49.144685Z","end":"2026-05-27T13:45:50.944921Z","steps":["trace[1824935090] 'read index received' (duration: 552.57795ms)","trace[1824935090] 'applied index is now lower than readState.Index' (duration: 1.24765703s)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:45:50.945017Z","caller":"traceutil/trace.go:171","msg":"trace[1225589048] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"1.799309185s","start":"2026-05-27T13:45:49.145692Z","end":"2026-05-27T13:45:50.945001Z","steps":["trace[1225589048] 'process raft request' (duration: 1.79896207s)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:50.94507Z","caller":"traceutil/trace.go:171","msg":"trace[693029012] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"1.800003356s","start":"2026-05-27T13:45:49.14506Z","end":"2026-05-27T13:45:50.945063Z","steps":["trace[693029012] 'process raft request' (duration: 1.799189644s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:50.945148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.800437803s","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-27T13:45:50.945206Z","caller":"traceutil/trace.go:171","msg":"trace[1073258226] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"1.798458542s","start":"2026-05-27T13:45:49.146731Z","end":"2026-05-27T13:45:50.945189Z","steps":["trace[1073258226] 'process raft request' (duration: 1.798082266s)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:50.945315Z","caller":"traceutil/trace.go:171","msg":"trace[56913202] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"1.358218939s","start":"2026-05-27T13:45:49.587086Z","end":"2026-05-27T13:45:50.945305Z","steps":["trace[56913202] 'process raft request' (duration: 1.357777333s)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:50.945319Z","caller":"traceutil/trace.go:171","msg":"trace[1729113665] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"1.799337975s","start":"2026-05-27T13:45:49.145958Z","end":"2026-05-27T13:45:50.945296Z","steps":["trace[1729113665] 'process raft request' (duration: 1.798755147s)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:50.945329Z","caller":"traceutil/trace.go:171","msg":"trace[1480574270] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"1.800031405s","start":"2026-05-27T13:45:49.14527Z","end":"2026-05-27T13:45:50.945301Z","steps":["trace[1480574270] 'process raft request' (duration: 1.799171313s)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:50.945373Z","caller":"traceutil/trace.go:171","msg":"trace[1804741409] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"1.798890518s","start":"2026-05-27T13:45:49.146472Z","end":"2026-05-27T13:45:50.945362Z","steps":["trace[1804741409] 'process raft request' (duration: 1.798296019s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:50.94668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:49.144763Z","time spent":"1.801895735s","remote":"127.0.0.1:51766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":649,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:45:50.946907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:49.145022Z","time spent":"1.801811943s","remote":"127.0.0.1:52016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":899,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:45:50.948134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:49.587061Z","time spent":"1.361036473s","remote":"127.0.0.1:51928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:45:50.948273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:49.14645Z","time spent":"1.801738812s","remote":"127.0.0.1:51846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4781,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:45:50.946965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:49.144736Z","time spent":"1.802206191s","remote":"127.0.0.1:52146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3691,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:45:50.947047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.487270627s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:45:50.949249Z","caller":"traceutil/trace.go:171","msg":"trace[2097825492] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:362; }","duration":"1.489507882s","start":"2026-05-27T13:45:49.459731Z","end":"2026-05-27T13:45:50.949239Z","steps":["trace[2097825492] 'agreement among raft nodes before linearized reading' (duration: 1.487283718s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:50.949369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:49.459713Z","time spent":"1.489627893s","remote":"127.0.0.1:51692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-27T13:45:50.947098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.578328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-27T13:45:50.949677Z","caller":"traceutil/trace.go:171","msg":"trace[1159657484] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:362; }","duration":"616.174997ms","start":"2026-05-27T13:45:50.333477Z","end":"2026-05-27T13:45:50.949652Z","steps":["trace[1159657484] 'agreement among raft nodes before linearized reading' (duration: 613.592207ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:50.949765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:50.333452Z","time spent":"616.28381ms","remote":"127.0.0.1:51928","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-27T13:45:50.947121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.13314731s","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-27T13:45:50.950012Z","caller":"traceutil/trace.go:171","msg":"trace[415094386] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:362; }","duration":"1.136063615s","start":"2026-05-27T13:45:49.813932Z","end":"2026-05-27T13:45:50.949996Z","steps":["trace[415094386] 'agreement among raft nodes before linearized reading' (duration: 1.13317447s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:50.947144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.461793838s","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-27T13:45:50.94744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:49.145685Z","time spent":"1.801718682s","remote":"127.0.0.1:52016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2094,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:45:50.945381Z","caller":"traceutil/trace.go:171","msg":"trace[1164651041] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"1.799902594s","start":"2026-05-27T13:45:49.145455Z","end":"2026-05-27T13:45:50.945357Z","steps":["trace[1164651041] 'process raft request' (duration: 1.799125783s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:50.947554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:49.145049Z","time spent":"1.802477284s","remote":"127.0.0.1:51836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":596,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:45:50.947579Z","caller":"traceutil/trace.go:171","msg":"trace[1250631581] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:362; }","duration":"1.802906111s","start":"2026-05-27T13:45:49.144664Z","end":"2026-05-27T13:45:50.94757Z","steps":["trace[1250631581] 'agreement among raft nodes before linearized reading' (duration: 1.800348231s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:50.947671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:49.146725Z","time spent":"1.80091999s","remote":"127.0.0.1:51864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":156,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:45:50.948255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:49.145949Z","time spent":"1.802280961s","remote":"127.0.0.1:52016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2191,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:45:50.94695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:49.14457Z","time spent":"1.802359303s","remote":"127.0.0.1:51942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1050,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:45:50.948357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:49.145255Z","time spent":"1.803064794s","remote":"127.0.0.1:51776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2163,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:45:50.950148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:49.813913Z","time spent":"1.136219698s","remote":"127.0.0.1:51928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-27T13:45:50.950445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:49.145447Z","time spent":"1.804964563s","remote":"127.0.0.1:51846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4311,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:45:50.950184Z","caller":"traceutil/trace.go:171","msg":"trace[1293435571] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:362; }","duration":"1.464825844s","start":"2026-05-27T13:45:49.485346Z","end":"2026-05-27T13:45:50.950172Z","steps":["trace[1293435571] 'agreement among raft nodes before linearized reading' (duration: 1.461784697s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:50.950834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:49.485271Z","time spent":"1.465551766s","remote":"127.0.0.1:51928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-27T13:45:50.95039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:49.144659Z","time spent":"1.805720875s","remote":"127.0.0.1:51864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"warn","ts":"2026-05-27T13:45:51.457765Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367957987935556,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-27T13:45:51.610035Z","caller":"traceutil/trace.go:171","msg":"trace[647910056] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"658.943957ms","start":"2026-05-27T13:45:50.951051Z","end":"2026-05-27T13:45:51.609995Z","steps":["trace[647910056] 'process raft request' (duration: 655.796739ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:51.610253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:50.951031Z","time spent":"659.118639ms","remote":"127.0.0.1:51776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1739,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:45:51.616442Z","caller":"traceutil/trace.go:171","msg":"trace[955705133] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"659.793499ms","start":"2026-05-27T13:45:50.95662Z","end":"2026-05-27T13:45:51.616414Z","steps":["trace[955705133] 'process raft request' (duration: 659.489964ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:51.616627Z","caller":"traceutil/trace.go:171","msg":"trace[394278433] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"658.100572ms","start":"2026-05-27T13:45:50.9585Z","end":"2026-05-27T13:45:51.616601Z","steps":["trace[394278433] 'process raft request' (duration: 657.813288ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:51.6168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:50.958482Z","time spent":"658.216774ms","remote":"127.0.0.1:51928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:45:51.616821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:50.956597Z","time spent":"659.933972ms","remote":"127.0.0.1:51846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3378,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:45:51.616917Z","caller":"traceutil/trace.go:171","msg":"trace[1458114913] linearizableReadLoop","detail":"{readStateIndex:386; appliedIndex:376; }","duration":"660.178414ms","start":"2026-05-27T13:45:50.956719Z","end":"2026-05-27T13:45:51.616898Z","steps":["trace[1458114913] 'read index received' (duration: 650.178811ms)","trace[1458114913] 'applied index is now lower than readState.Index' (duration: 9.998593ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:45:51.617082Z","caller":"traceutil/trace.go:171","msg":"trace[1812231757] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"658.507208ms","start":"2026-05-27T13:45:50.958567Z","end":"2026-05-27T13:45:51.617074Z","steps":["trace[1812231757] 'process raft request' (duration: 657.810378ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:51.617207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:50.958562Z","time spent":"658.566659ms","remote":"127.0.0.1:51928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:45:51.617243Z","caller":"traceutil/trace.go:171","msg":"trace[1031944645] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"658.476387ms","start":"2026-05-27T13:45:50.958759Z","end":"2026-05-27T13:45:51.617236Z","steps":["trace[1031944645] 'process raft request' (duration: 657.932289ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:51.617295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:50.958752Z","time spent":"658.515349ms","remote":"127.0.0.1:51766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":654,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:45:51.617442Z","caller":"traceutil/trace.go:171","msg":"trace[784911555] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"653.075794ms","start":"2026-05-27T13:45:50.964354Z","end":"2026-05-27T13:45:51.617429Z","steps":["trace[784911555] 'process raft request' (duration: 652.423754ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:51.617512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:50.964335Z","time spent":"653.135215ms","remote":"127.0.0.1:51864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":172,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:45:51.617514Z","caller":"traceutil/trace.go:171","msg":"trace[33265719] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"653.207465ms","start":"2026-05-27T13:45:50.964296Z","end":"2026-05-27T13:45:51.617504Z","steps":["trace[33265719] 'process raft request' (duration: 652.456294ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:51.617563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:50.96428Z","time spent":"653.259727ms","remote":"127.0.0.1:51846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3527,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:45:51.617946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.195851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7302"} {"level":"info","ts":"2026-05-27T13:45:51.618011Z","caller":"traceutil/trace.go:171","msg":"trace[1732082579] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:372; }","duration":"661.304642ms","start":"2026-05-27T13:45:50.956692Z","end":"2026-05-27T13:45:51.617996Z","steps":["trace[1732082579] 'agreement among raft nodes before linearized reading' (duration: 661.15632ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:51.618046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:50.956685Z","time spent":"661.354563ms","remote":"127.0.0.1:51846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7325,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"info","ts":"2026-05-27T13:45:51.618229Z","caller":"traceutil/trace.go:171","msg":"trace[1472213472] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"653.696764ms","start":"2026-05-27T13:45:50.964523Z","end":"2026-05-27T13:45:51.61822Z","steps":["trace[1472213472] 'process raft request' (duration: 652.275962ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:51.618298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:50.964514Z","time spent":"653.738534ms","remote":"127.0.0.1:52016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2264,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:45:51.61842Z","caller":"traceutil/trace.go:171","msg":"trace[665256506] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"650.144128ms","start":"2026-05-27T13:45:50.96827Z","end":"2026-05-27T13:45:51.618414Z","steps":["trace[665256506] 'process raft request' (duration: 648.578204ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:51.617209Z","caller":"traceutil/trace.go:171","msg":"trace[1973593413] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"658.58847ms","start":"2026-05-27T13:45:50.958607Z","end":"2026-05-27T13:45:51.617196Z","steps":["trace[1973593413] 'process raft request' (duration: 658.054392ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:51.618461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:50.968259Z","time spent":"650.184509ms","remote":"127.0.0.1:52016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3461,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:45:51.618503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:50.9586Z","time spent":"659.865879ms","remote":"127.0.0.1:51928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:45:51.618705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.11146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3706"} {"level":"info","ts":"2026-05-27T13:45:51.61874Z","caller":"traceutil/trace.go:171","msg":"trace[1420498301] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:373; }","duration":"654.15459ms","start":"2026-05-27T13:45:50.964578Z","end":"2026-05-27T13:45:51.618733Z","steps":["trace[1420498301] 'agreement among raft nodes before linearized reading' (duration: 654.093769ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:51.61876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:50.964574Z","time spent":"654.18166ms","remote":"127.0.0.1:52146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":3729,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"warn","ts":"2026-05-27T13:45:51.618034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"653.517611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:45:51.618907Z","caller":"traceutil/trace.go:171","msg":"trace[599565345] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:373; }","duration":"654.406564ms","start":"2026-05-27T13:45:50.964482Z","end":"2026-05-27T13:45:51.618889Z","steps":["trace[599565345] 'agreement among raft nodes before linearized reading' (duration: 653.467671ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:51.619348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:50.964476Z","time spent":"654.855982ms","remote":"127.0.0.1:51706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-27T13:45:55.876156Z","caller":"traceutil/trace.go:171","msg":"trace[658460784] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"239.703415ms","start":"2026-05-27T13:45:55.636423Z","end":"2026-05-27T13:45:55.876127Z","steps":["trace[658460784] 'process raft request' (duration: 239.540783ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:56.450651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.857415ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:45:56.45084Z","caller":"traceutil/trace.go:171","msg":"trace[1718859100] linearizableReadLoop","detail":"{readStateIndex:430; appliedIndex:428; }","duration":"155.890718ms","start":"2026-05-27T13:45:56.294932Z","end":"2026-05-27T13:45:56.450823Z","steps":["trace[1718859100] 'read index received' (duration: 75.191µs)","trace[1718859100] 'applied index is now lower than readState.Index' (duration: 155.814217ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:45:56.450924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.990779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"} {"level":"info","ts":"2026-05-27T13:45:56.450959Z","caller":"traceutil/trace.go:171","msg":"trace[920861434] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:414; }","duration":"156.083511ms","start":"2026-05-27T13:45:56.294866Z","end":"2026-05-27T13:45:56.450949Z","steps":["trace[920861434] 'agreement among raft nodes before linearized reading' (duration: 156.01308ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:56.450993Z","caller":"traceutil/trace.go:171","msg":"trace[186761860] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"814.029982ms","start":"2026-05-27T13:45:55.636937Z","end":"2026-05-27T13:45:56.450967Z","steps":["trace[186761860] 'process raft request' (duration: 472.74609ms)","trace[186761860] 'compare' (duration: 340.725233ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:45:56.451132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:55.636915Z","time spent":"814.148503ms","remote":"127.0.0.1:51928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:45:56.451199Z","caller":"traceutil/trace.go:171","msg":"trace[982030636] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"814.149623ms","start":"2026-05-27T13:45:55.637038Z","end":"2026-05-27T13:45:56.451188Z","steps":["trace[982030636] 'process raft request' (duration: 813.711076ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:45:56.451266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:45:55.637023Z","time spent":"814.208474ms","remote":"127.0.0.1:51928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:46:19.130822Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367957987935887,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-27T13:46:19.236978Z","caller":"traceutil/trace.go:171","msg":"trace[583000865] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"864.144274ms","start":"2026-05-27T13:46:18.3728Z","end":"2026-05-27T13:46:19.236945Z","steps":["trace[583000865] 'process raft request' (duration: 863.951851ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:19.237142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:18.372781Z","time spent":"864.289356ms","remote":"127.0.0.1:51730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:46:19.259746Z","caller":"traceutil/trace.go:171","msg":"trace[584232244] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"882.690678ms","start":"2026-05-27T13:46:18.377031Z","end":"2026-05-27T13:46:19.259722Z","steps":["trace[584232244] 'process raft request' (duration: 882.359784ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:19.259781Z","caller":"traceutil/trace.go:171","msg":"trace[783883188] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"882.765629ms","start":"2026-05-27T13:46:18.37699Z","end":"2026-05-27T13:46:19.259755Z","steps":["trace[783883188] 'process raft request' (duration: 881.969669ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:19.25992Z","caller":"traceutil/trace.go:171","msg":"trace[75038878] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"864.331264ms","start":"2026-05-27T13:46:18.395555Z","end":"2026-05-27T13:46:19.259886Z","steps":["trace[75038878] 'process raft request' (duration: 863.98553ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:19.259954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:18.377026Z","time spent":"882.771299ms","remote":"127.0.0.1:51730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:46:19.259941Z","caller":"traceutil/trace.go:171","msg":"trace[144147622] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"863.565325ms","start":"2026-05-27T13:46:18.396344Z","end":"2026-05-27T13:46:19.259909Z","steps":["trace[144147622] 'process raft request' (duration: 863.354543ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:19.259991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:18.376979Z","time spent":"882.90586ms","remote":"127.0.0.1:51730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:46:19.260035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:18.396325Z","time spent":"863.667456ms","remote":"127.0.0.1:51730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:46:19.260117Z","caller":"traceutil/trace.go:171","msg":"trace[995791771] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"864.720839ms","start":"2026-05-27T13:46:18.395385Z","end":"2026-05-27T13:46:19.260106Z","steps":["trace[995791771] 'process raft request' (duration: 864.073911ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:19.260024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:18.395549Z","time spent":"864.430616ms","remote":"127.0.0.1:51730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:46:19.260166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:18.395364Z","time spent":"864.77983ms","remote":"127.0.0.1:51730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:46:19.260203Z","caller":"traceutil/trace.go:171","msg":"trace[277493183] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"864.720479ms","start":"2026-05-27T13:46:18.39547Z","end":"2026-05-27T13:46:19.260191Z","steps":["trace[277493183] 'process raft request' (duration: 864.032191ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:19.260212Z","caller":"traceutil/trace.go:171","msg":"trace[2102713444] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"863.727897ms","start":"2026-05-27T13:46:18.396453Z","end":"2026-05-27T13:46:19.260181Z","steps":["trace[2102713444] 'process raft request' (duration: 863.306112ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:19.260263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:18.39546Z","time spent":"864.77611ms","remote":"127.0.0.1:51730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:46:19.260296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:18.396448Z","time spent":"863.790597ms","remote":"127.0.0.1:51730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:46:19.260346Z","caller":"traceutil/trace.go:171","msg":"trace[885642250] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"839.885164ms","start":"2026-05-27T13:46:18.420451Z","end":"2026-05-27T13:46:19.260336Z","steps":["trace[885642250] 'process raft request' (duration: 839.377017ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:19.260399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:18.420433Z","time spent":"839.944065ms","remote":"127.0.0.1:51730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:46:19.260617Z","caller":"traceutil/trace.go:171","msg":"trace[1472488449] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"829.551674ms","start":"2026-05-27T13:46:18.43104Z","end":"2026-05-27T13:46:19.260591Z","steps":["trace[1472488449] 'process raft request' (duration: 829.380591ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:19.26073Z","caller":"traceutil/trace.go:171","msg":"trace[1925577109] linearizableReadLoop","detail":"{readStateIndex:563; appliedIndex:551; }","duration":"630.852138ms","start":"2026-05-27T13:46:18.629861Z","end":"2026-05-27T13:46:19.260713Z","steps":["trace[1925577109] 'read index received' (duration: 606.927136ms)","trace[1925577109] 'applied index is now lower than readState.Index' (duration: 23.923772ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:46:19.260743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:18.430988Z","time spent":"829.688595ms","remote":"127.0.0.1:51730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:46:19.260815Z","caller":"traceutil/trace.go:171","msg":"trace[1827497797] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"812.281763ms","start":"2026-05-27T13:46:18.448522Z","end":"2026-05-27T13:46:19.260804Z","steps":["trace[1827497797] 'process raft request' (duration: 811.99233ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:19.260869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:18.448491Z","time spent":"812.346463ms","remote":"127.0.0.1:51730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:46:19.260942Z","caller":"traceutil/trace.go:171","msg":"trace[1493064944] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"717.701491ms","start":"2026-05-27T13:46:18.543209Z","end":"2026-05-27T13:46:19.260911Z","steps":["trace[1493064944] 'process raft request' (duration: 717.382558ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:19.261014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:18.54318Z","time spent":"717.792323ms","remote":"127.0.0.1:51730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:46:19.261172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.309023ms","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-27T13:46:19.261226Z","caller":"traceutil/trace.go:171","msg":"trace[940799026] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:540; }","duration":"631.394394ms","start":"2026-05-27T13:46:18.629818Z","end":"2026-05-27T13:46:19.261213Z","steps":["trace[940799026] 'agreement among raft nodes before linearized reading' (duration: 631.131231ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:19.261273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:18.629799Z","time spent":"631.464156ms","remote":"127.0.0.1:51928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-27T13:46:19.265698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.004941ms","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-27T13:46:19.265892Z","caller":"traceutil/trace.go:171","msg":"trace[244589334] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:542; }","duration":"621.226954ms","start":"2026-05-27T13:46:18.644645Z","end":"2026-05-27T13:46:19.265872Z","steps":["trace[244589334] 'agreement among raft nodes before linearized reading' (duration: 620.94973ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:19.26602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:18.644634Z","time spent":"621.371347ms","remote":"127.0.0.1:51928","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-27T13:46:19.266434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.514253ms","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-27T13:46:19.266639Z","caller":"traceutil/trace.go:171","msg":"trace[883192211] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:542; }","duration":"139.681825ms","start":"2026-05-27T13:46:19.12691Z","end":"2026-05-27T13:46:19.266592Z","steps":["trace[883192211] 'agreement among raft nodes before linearized reading' (duration: 139.487402ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:19.266835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.670568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:46:19.266942Z","caller":"traceutil/trace.go:171","msg":"trace[1261686908] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:542; }","duration":"576.82324ms","start":"2026-05-27T13:46:18.690091Z","end":"2026-05-27T13:46:19.266914Z","steps":["trace[1261686908] 'agreement among raft nodes before linearized reading' (duration: 576.625447ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:19.267002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:18.690077Z","time spent":"576.916412ms","remote":"127.0.0.1:51706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-27T13:46:22.14188Z","caller":"traceutil/trace.go:171","msg":"trace[1579240116] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"129.155762ms","start":"2026-05-27T13:46:22.012698Z","end":"2026-05-27T13:46:22.141854Z","steps":["trace[1579240116] 'process raft request' (duration: 129.029481ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:25.515883Z","caller":"traceutil/trace.go:171","msg":"trace[2048725162] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:664; }","duration":"213.527371ms","start":"2026-05-27T13:46:25.302314Z","end":"2026-05-27T13:46:25.515841Z","steps":["trace[2048725162] 'read index received' (duration: 212.60209ms)","trace[2048725162] 'applied index is now lower than readState.Index' (duration: 923.981µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:46:25.515952Z","caller":"traceutil/trace.go:171","msg":"trace[541505365] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"365.665384ms","start":"2026-05-27T13:46:25.150263Z","end":"2026-05-27T13:46:25.515928Z","steps":["trace[541505365] 'process raft request' (duration: 364.956286ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:25.516133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.647469ms","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-27T13:46:25.516145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:25.150234Z","time spent":"365.773556ms","remote":"127.0.0.1:51770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:46:25.516192Z","caller":"traceutil/trace.go:171","msg":"trace[392549154] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:636; }","duration":"193.770611ms","start":"2026-05-27T13:46:25.322406Z","end":"2026-05-27T13:46:25.516177Z","steps":["trace[392549154] 'agreement among raft nodes before linearized reading' (duration: 193.627549ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:25.516269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.013609ms","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-27T13:46:25.516362Z","caller":"traceutil/trace.go:171","msg":"trace[135899711] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:636; }","duration":"183.151602ms","start":"2026-05-27T13:46:25.333192Z","end":"2026-05-27T13:46:25.516344Z","steps":["trace[135899711] 'agreement among raft nodes before linearized reading' (duration: 182.942589ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:25.5172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.856137ms","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-27T13:46:25.517535Z","caller":"traceutil/trace.go:171","msg":"trace[1640957109] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:636; }","duration":"215.017209ms","start":"2026-05-27T13:46:25.302296Z","end":"2026-05-27T13:46:25.517313Z","steps":["trace[1640957109] 'agreement among raft nodes before linearized reading' (duration: 213.678902ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:25.799651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.82783ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:46:25.799884Z","caller":"traceutil/trace.go:171","msg":"trace[2074061088] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"279.725448ms","start":"2026-05-27T13:46:25.520119Z","end":"2026-05-27T13:46:25.799844Z","steps":["trace[2074061088] 'process raft request' (duration: 26.601514ms)","trace[2074061088] 'compare' (duration: 252.616358ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:46:25.799933Z","caller":"traceutil/trace.go:171","msg":"trace[1293687579] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:665; }","duration":"251.616414ms","start":"2026-05-27T13:46:25.548299Z","end":"2026-05-27T13:46:25.799916Z","steps":["trace[1293687579] 'read index received' (duration: 36.283901ms)","trace[1293687579] 'applied index is now lower than readState.Index' (duration: 215.331223ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:46:25.800027Z","caller":"traceutil/trace.go:171","msg":"trace[428388497] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"278.444202ms","start":"2026-05-27T13:46:25.52157Z","end":"2026-05-27T13:46:25.800014Z","steps":["trace[428388497] 'process raft request' (duration: 278.213309ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:25.800121Z","caller":"traceutil/trace.go:171","msg":"trace[1570550223] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"278.253059ms","start":"2026-05-27T13:46:25.521822Z","end":"2026-05-27T13:46:25.800075Z","steps":["trace[1570550223] 'process raft request' (duration: 278.042837ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:25.800235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.907808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ch4c8\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-27T13:46:25.80042Z","caller":"traceutil/trace.go:171","msg":"trace[728680429] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ch4c8; range_end:; response_count:1; response_revision:639; }","duration":"252.142201ms","start":"2026-05-27T13:46:25.548251Z","end":"2026-05-27T13:46:25.800393Z","steps":["trace[728680429] 'agreement among raft nodes before linearized reading' (duration: 251.778346ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:27.147602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"888.509021ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:46:27.147707Z","caller":"traceutil/trace.go:171","msg":"trace[1641200759] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:668; }","duration":"1.347721247s","start":"2026-05-27T13:46:25.799969Z","end":"2026-05-27T13:46:27.147691Z","steps":["trace[1641200759] 'read index received' (duration: 459.057844ms)","trace[1641200759] 'applied index is now lower than readState.Index' (duration: 888.662323ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:46:27.147922Z","caller":"traceutil/trace.go:171","msg":"trace[454546933] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"1.571878787s","start":"2026-05-27T13:46:25.576032Z","end":"2026-05-27T13:46:27.147911Z","steps":["trace[454546933] 'process raft request' (duration: 682.999452ms)","trace[454546933] 'compare' (duration: 888.342389ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:46:27.147971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:25.576002Z","time spent":"1.571946338s","remote":"127.0.0.1:52194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:46:27.148141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.456649183s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:46:27.148175Z","caller":"traceutil/trace.go:171","msg":"trace[1633609651] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:640; }","duration":"1.456728883s","start":"2026-05-27T13:46:25.691437Z","end":"2026-05-27T13:46:27.148166Z","steps":["trace[1633609651] 'agreement among raft nodes before linearized reading' (duration: 1.456647792s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:27.148202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:25.69141Z","time spent":"1.456786394s","remote":"127.0.0.1:51706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-27T13:46:27.64833Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367957987936077,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T13:46:27.71949Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.300877006s","expected-duration":"1s"} {"level":"info","ts":"2026-05-27T13:46:27.719886Z","caller":"traceutil/trace.go:171","msg":"trace[929969316] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"1.90454714s","start":"2026-05-27T13:46:25.81532Z","end":"2026-05-27T13:46:27.719867Z","steps":["trace[929969316] 'process raft request' (duration: 1.904433778s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:27.720016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:25.815295Z","time spent":"1.904647441s","remote":"127.0.0.1:51846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:46:27.815337Z","caller":"traceutil/trace.go:171","msg":"trace[1593052047] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:669; }","duration":"667.577699ms","start":"2026-05-27T13:46:27.147731Z","end":"2026-05-27T13:46:27.815309Z","steps":["trace[1593052047] 'read index received' (duration: 572.033988ms)","trace[1593052047] 'applied index is now lower than readState.Index' (duration: 95.542291ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:46:27.815706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"666.565146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:46:27.815752Z","caller":"traceutil/trace.go:171","msg":"trace[1974378852] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:641; }","duration":"666.737218ms","start":"2026-05-27T13:46:27.149001Z","end":"2026-05-27T13:46:27.815739Z","steps":["trace[1974378852] 'agreement among raft nodes before linearized reading' (duration: 666.635816ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:27.815793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:27.148985Z","time spent":"666.801199ms","remote":"127.0.0.1:51692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-27T13:46:27.81576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.662824102s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-27T13:46:27.816077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.485779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:46:27.816219Z","caller":"traceutil/trace.go:171","msg":"trace[1876463263] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:641; }","duration":"658.677421ms","start":"2026-05-27T13:46:27.157515Z","end":"2026-05-27T13:46:27.816192Z","steps":["trace[1876463263] 'agreement among raft nodes before linearized reading' (duration: 658.423368ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:27.8163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:27.157483Z","time spent":"658.804922ms","remote":"127.0.0.1:51904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-05-27T13:46:27.816158Z","caller":"traceutil/trace.go:171","msg":"trace[1685424261] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:641; }","duration":"1.663206187s","start":"2026-05-27T13:46:26.152817Z","end":"2026-05-27T13:46:27.816023Z","steps":["trace[1685424261] 'agreement among raft nodes before linearized reading' (duration: 1.66260117s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:27.816438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:26.152796Z","time spent":"1.663625161s","remote":"127.0.0.1:51928","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-27T13:46:29.198216Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367957987936084,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T13:46:29.698978Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367957987936084,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T13:46:29.869772Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.627656608s","expected-duration":"1s"} {"level":"info","ts":"2026-05-27T13:46:29.870685Z","caller":"traceutil/trace.go:171","msg":"trace[1228959807] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:675; }","duration":"1.172816513s","start":"2026-05-27T13:46:28.697844Z","end":"2026-05-27T13:46:29.87066Z","steps":["trace[1228959807] 'read index received' (duration: 1.172184105s)","trace[1228959807] 'applied index is now lower than readState.Index' (duration: 631.248µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:46:29.870811Z","caller":"traceutil/trace.go:171","msg":"trace[1510081809] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"1.662544408s","start":"2026-05-27T13:46:28.208259Z","end":"2026-05-27T13:46:29.870803Z","steps":["trace[1510081809] 'process raft request' (duration: 1.66196865s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:29.870905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:28.208232Z","time spent":"1.662605578s","remote":"127.0.0.1:51770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:46:29.871109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.173224688s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:46:29.871203Z","caller":"traceutil/trace.go:171","msg":"trace[1258821414] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"1.17337461s","start":"2026-05-27T13:46:28.697803Z","end":"2026-05-27T13:46:29.871177Z","steps":["trace[1258821414] 'agreement among raft nodes before linearized reading' (duration: 1.173185428s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:29.871254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:28.697785Z","time spent":"1.173461051s","remote":"127.0.0.1:51692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-27T13:46:31.450169Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.484700991s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-27T13:46:31.453269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.223534096s","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-27T13:46:31.453457Z","caller":"traceutil/trace.go:171","msg":"trace[489982240] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:646; }","duration":"1.223718278s","start":"2026-05-27T13:46:30.229698Z","end":"2026-05-27T13:46:31.453416Z","steps":["trace[489982240] 'range keys from in-memory index tree' (duration: 1.223496005s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:31.453523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.487949789s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:46:31.453727Z","caller":"traceutil/trace.go:171","msg":"trace[87109481] linearizableReadLoop","detail":"{readStateIndex:677; appliedIndex:676; }","duration":"1.576776957s","start":"2026-05-27T13:46:29.876931Z","end":"2026-05-27T13:46:31.453708Z","steps":["trace[87109481] 'read index received' (duration: 88.563725ms)","trace[87109481] 'applied index is now lower than readState.Index' (duration: 1.488211262s)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:46:31.453731Z","caller":"traceutil/trace.go:171","msg":"trace[1831466512] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"1.576874098s","start":"2026-05-27T13:46:29.876833Z","end":"2026-05-27T13:46:31.453707Z","steps":["trace[1831466512] 'process raft request' (duration: 88.613435ms)","trace[1831466512] 'compare' (duration: 1.487813758s)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:46:31.453859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:29.876816Z","time spent":"1.576987969s","remote":"127.0.0.1:51928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:46:31.454028Z","caller":"traceutil/trace.go:171","msg":"trace[1720081510] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"1.573946254s","start":"2026-05-27T13:46:29.880065Z","end":"2026-05-27T13:46:31.454011Z","steps":["trace[1720081510] 'process raft request' (duration: 1.573556649s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:31.454053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.577106521s","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-27T13:46:31.454103Z","caller":"traceutil/trace.go:171","msg":"trace[322916610] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:649; }","duration":"1.577193392s","start":"2026-05-27T13:46:29.876893Z","end":"2026-05-27T13:46:31.454086Z","steps":["trace[322916610] 'agreement among raft nodes before linearized reading' (duration: 1.576956608s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:31.454131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:29.879986Z","time spent":"1.574095325s","remote":"127.0.0.1:51928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:46:31.454163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:29.876887Z","time spent":"1.577263973s","remote":"127.0.0.1:51928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-27T13:46:31.454279Z","caller":"traceutil/trace.go:171","msg":"trace[1010326428] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"1.570768565s","start":"2026-05-27T13:46:29.883495Z","end":"2026-05-27T13:46:31.454264Z","steps":["trace[1010326428] 'process raft request' (duration: 1.570218338s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:31.454371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:29.883484Z","time spent":"1.570840526s","remote":"127.0.0.1:51928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:46:31.454476Z","caller":"traceutil/trace.go:171","msg":"trace[544413498] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"1.525319174s","start":"2026-05-27T13:46:29.929143Z","end":"2026-05-27T13:46:31.454463Z","steps":["trace[544413498] 'process raft request' (duration: 1.524711386s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:31.45458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:29.929119Z","time spent":"1.525408895s","remote":"127.0.0.1:51904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:46:31.45481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.574417638s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:46:31.454876Z","caller":"traceutil/trace.go:171","msg":"trace[1114642459] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:651; }","duration":"1.574483209s","start":"2026-05-27T13:46:29.880378Z","end":"2026-05-27T13:46:31.454862Z","steps":["trace[1114642459] 'agreement among raft nodes before linearized reading' (duration: 1.574360777s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:31.454929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:29.880346Z","time spent":"1.574571669s","remote":"127.0.0.1:51706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-27T13:46:33.156459Z","caller":"traceutil/trace.go:171","msg":"trace[1926180676] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"419.853965ms","start":"2026-05-27T13:46:32.736573Z","end":"2026-05-27T13:46:33.156427Z","steps":["trace[1926180676] 'process raft request' (duration: 419.694144ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:33.156684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:32.73656Z","time spent":"420.006918ms","remote":"127.0.0.1:51928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:46:35.905434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.14713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-05-27T13:46:35.905571Z","caller":"traceutil/trace.go:171","msg":"trace[1441446447] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:723; }","duration":"137.335172ms","start":"2026-05-27T13:46:35.768206Z","end":"2026-05-27T13:46:35.905542Z","steps":["trace[1441446447] 'range keys from in-memory index tree' (duration: 136.961538ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:43.450759Z","caller":"traceutil/trace.go:171","msg":"trace[2017550175] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"223.361682ms","start":"2026-05-27T13:46:43.227366Z","end":"2026-05-27T13:46:43.450728Z","steps":["trace[2017550175] 'process raft request' (duration: 223.20173ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:44.690814Z","caller":"traceutil/trace.go:171","msg":"trace[684741457] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"148.193222ms","start":"2026-05-27T13:46:44.542516Z","end":"2026-05-27T13:46:44.690709Z","steps":["trace[684741457] 'process raft request' (duration: 148.045849ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:47.192438Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367957987936414,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T13:46:47.693172Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367957987936414,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T13:46:48.101414Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.374893425s","expected-duration":"1s"} {"level":"info","ts":"2026-05-27T13:46:48.101905Z","caller":"traceutil/trace.go:171","msg":"trace[253998596] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"1.431054107s","start":"2026-05-27T13:46:46.670827Z","end":"2026-05-27T13:46:48.101881Z","steps":["trace[253998596] 'process raft request' (duration: 1.430785775s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:48.102087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:46.67081Z","time spent":"1.431169028s","remote":"127.0.0.1:51846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:46:48.108258Z","caller":"traceutil/trace.go:171","msg":"trace[439378529] linearizableReadLoop","detail":"{readStateIndex:847; appliedIndex:845; }","duration":"1.416519337s","start":"2026-05-27T13:46:46.69171Z","end":"2026-05-27T13:46:48.108229Z","steps":["trace[439378529] 'read index received' (duration: 1.410008338s)","trace[439378529] 'applied index is now lower than readState.Index' (duration: 6.509669ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:46:48.108414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.416681539s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:46:48.108473Z","caller":"traceutil/trace.go:171","msg":"trace[329408034] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:811; }","duration":"1.416792652s","start":"2026-05-27T13:46:46.691663Z","end":"2026-05-27T13:46:48.108456Z","steps":["trace[329408034] 'agreement among raft nodes before linearized reading' (duration: 1.41667998s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:48.108506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:46.691645Z","time spent":"1.416852772s","remote":"127.0.0.1:51706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-27T13:46:48.108424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.023493705s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:46:48.108741Z","caller":"traceutil/trace.go:171","msg":"trace[544994980] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:811; }","duration":"1.02384753s","start":"2026-05-27T13:46:47.084861Z","end":"2026-05-27T13:46:48.108709Z","steps":["trace[544994980] 'agreement among raft nodes before linearized reading' (duration: 1.023494346s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:48.108777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:47.084848Z","time spent":"1.023916011s","remote":"127.0.0.1:52084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-05-27T13:46:48.109011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.042576ms","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-27T13:46:48.109011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.108915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-27T13:46:48.109001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.049424ms","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":"info","ts":"2026-05-27T13:46:48.109085Z","caller":"traceutil/trace.go:171","msg":"trace[72878786] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:811; }","duration":"549.253947ms","start":"2026-05-27T13:46:47.559813Z","end":"2026-05-27T13:46:48.109067Z","steps":["trace[72878786] 'agreement among raft nodes before linearized reading' (duration: 549.023595ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:48.109123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:47.559777Z","time spent":"549.339807ms","remote":"127.0.0.1:51928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-27T13:46:48.109113Z","caller":"traceutil/trace.go:171","msg":"trace[1871281947] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:811; }","duration":"139.198025ms","start":"2026-05-27T13:46:47.969891Z","end":"2026-05-27T13:46:48.109089Z","steps":["trace[1871281947] 'agreement among raft nodes before linearized reading' (duration: 139.002373ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:48.109205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.408241ms","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-27T13:46:48.10924Z","caller":"traceutil/trace.go:171","msg":"trace[1352151479] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:811; }","duration":"645.489693ms","start":"2026-05-27T13:46:47.46374Z","end":"2026-05-27T13:46:48.10923Z","steps":["trace[1352151479] 'agreement among raft nodes before linearized reading' (duration: 645.385941ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:48.109267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:47.463707Z","time spent":"645.553673ms","remote":"127.0.0.1:51928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-27T13:46:48.109326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.58586ms","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-27T13:46:48.109351Z","caller":"traceutil/trace.go:171","msg":"trace[596586252] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:811; }","duration":"139.654071ms","start":"2026-05-27T13:46:47.969688Z","end":"2026-05-27T13:46:48.109342Z","steps":["trace[596586252] 'agreement among raft nodes before linearized reading' (duration: 139.61292ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:48.109399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.879916ms","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-27T13:46:48.109428Z","caller":"traceutil/trace.go:171","msg":"trace[692182219] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:811; }","duration":"575.942596ms","start":"2026-05-27T13:46:47.533477Z","end":"2026-05-27T13:46:48.10942Z","steps":["trace[692182219] 'agreement among raft nodes before linearized reading' (duration: 575.850375ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:48.109453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:47.53346Z","time spent":"575.986057ms","remote":"127.0.0.1:51928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-27T13:46:48.109461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.730912ms","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":"info","ts":"2026-05-27T13:46:48.109486Z","caller":"traceutil/trace.go:171","msg":"trace[1808363140] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:811; }","duration":"139.776252ms","start":"2026-05-27T13:46:47.969699Z","end":"2026-05-27T13:46:48.109475Z","steps":["trace[1808363140] 'agreement among raft nodes before linearized reading' (duration: 139.743042ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:48.109131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.262648ms","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-27T13:46:48.109516Z","caller":"traceutil/trace.go:171","msg":"trace[1076877238] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:811; }","duration":"563.675203ms","start":"2026-05-27T13:46:47.545831Z","end":"2026-05-27T13:46:48.109507Z","steps":["trace[1076877238] 'agreement among raft nodes before linearized reading' (duration: 563.247019ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:48.109549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:47.545811Z","time spent":"563.728774ms","remote":"127.0.0.1:51928","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-27T13:46:48.109058Z","caller":"traceutil/trace.go:171","msg":"trace[409142652] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:811; }","duration":"563.120868ms","start":"2026-05-27T13:46:47.545921Z","end":"2026-05-27T13:46:48.109042Z","steps":["trace[409142652] 'agreement among raft nodes before linearized reading' (duration: 562.983566ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:48.10966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:47.545903Z","time spent":"563.748704ms","remote":"127.0.0.1:51928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-27T13:48:12.75652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.141891ms","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-27T13:48:12.756623Z","caller":"traceutil/trace.go:171","msg":"trace[120699747] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1219; }","duration":"139.291063ms","start":"2026-05-27T13:48:12.617312Z","end":"2026-05-27T13:48:12.756603Z","steps":["trace[120699747] 'range keys from in-memory index tree' (duration: 139.000401ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:12.756635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.279427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-27T13:48:12.756521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.565948ms","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-27T13:48:12.756701Z","caller":"traceutil/trace.go:171","msg":"trace[970400768] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1219; }","duration":"136.357498ms","start":"2026-05-27T13:48:12.620323Z","end":"2026-05-27T13:48:12.756681Z","steps":["trace[970400768] 'range keys from in-memory index tree' (duration: 136.167067ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:12.756725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.001808ms","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-27T13:48:12.756753Z","caller":"traceutil/trace.go:171","msg":"trace[829973546] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1219; }","duration":"124.78314ms","start":"2026-05-27T13:48:12.631912Z","end":"2026-05-27T13:48:12.756695Z","steps":["trace[829973546] 'range keys from in-memory index tree' (duration: 124.407036ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:48:12.756815Z","caller":"traceutil/trace.go:171","msg":"trace[1762104127] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1219; }","duration":"121.116659ms","start":"2026-05-27T13:48:12.635679Z","end":"2026-05-27T13:48:12.756796Z","steps":["trace[1762104127] 'range keys from in-memory index tree' (duration: 120.802646ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:48:12.896962Z","caller":"traceutil/trace.go:171","msg":"trace[1378330103] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"136.302289ms","start":"2026-05-27T13:48:12.760614Z","end":"2026-05-27T13:48:12.896916Z","steps":["trace[1378330103] 'process raft request' (duration: 136.265878ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:48:12.89736Z","caller":"traceutil/trace.go:171","msg":"trace[1318702259] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"137.133095ms","start":"2026-05-27T13:48:12.760169Z","end":"2026-05-27T13:48:12.897302Z","steps":["trace[1318702259] 'process raft request' (duration: 136.552019ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:48:12.897577Z","caller":"traceutil/trace.go:171","msg":"trace[1785322228] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"137.025064ms","start":"2026-05-27T13:48:12.760466Z","end":"2026-05-27T13:48:12.897491Z","steps":["trace[1785322228] 'process raft request' (duration: 136.379068ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:48:39.824884Z","caller":"traceutil/trace.go:171","msg":"trace[247466667] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"110.806239ms","start":"2026-05-27T13:48:39.714054Z","end":"2026-05-27T13:48:39.82486Z","steps":["trace[247466667] 'process raft request' (duration: 110.672928ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:49:03.491322Z","caller":"traceutil/trace.go:171","msg":"trace[583916135] transaction","detail":"{read_only:false; response_revision:1428; number_of_response:1; }","duration":"290.640494ms","start":"2026-05-27T13:49:03.200652Z","end":"2026-05-27T13:49:03.491293Z","steps":["trace[583916135] 'process raft request' (duration: 248.379635ms)","trace[583916135] 'compare' (duration: 41.871106ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:49:03.524207Z","caller":"traceutil/trace.go:171","msg":"trace[860699243] linearizableReadLoop","detail":"{readStateIndex:1498; appliedIndex:1495; }","duration":"321.513352ms","start":"2026-05-27T13:49:03.202669Z","end":"2026-05-27T13:49:03.524182Z","steps":["trace[860699243] 'read index received' (duration: 246.51859ms)","trace[860699243] 'applied index is now lower than readState.Index' (duration: 74.993782ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:49:03.524248Z","caller":"traceutil/trace.go:171","msg":"trace[1770674494] transaction","detail":"{read_only:false; response_revision:1429; number_of_response:1; }","duration":"323.089255ms","start":"2026-05-27T13:49:03.201128Z","end":"2026-05-27T13:49:03.524217Z","steps":["trace[1770674494] 'process raft request' (duration: 322.859683ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:49:03.524388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:49:03.201115Z","time spent":"323.199185ms","remote":"127.0.0.1:51928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:49:03.524497Z","caller":"traceutil/trace.go:171","msg":"trace[276947603] transaction","detail":"{read_only:false; response_revision:1430; number_of_response:1; }","duration":"322.687292ms","start":"2026-05-27T13:49:03.201575Z","end":"2026-05-27T13:49:03.524262Z","steps":["trace[276947603] 'process raft request' (duration: 322.569611ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:49:03.524696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.812919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:49:03.524767Z","caller":"traceutil/trace.go:171","msg":"trace[913351605] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1430; }","duration":"212.90509ms","start":"2026-05-27T13:49:03.311846Z","end":"2026-05-27T13:49:03.524751Z","steps":["trace[913351605] 'agreement among raft nodes before linearized reading' (duration: 212.762228ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:49:03.524543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.409714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2918"} {"level":"warn","ts":"2026-05-27T13:49:03.524874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.177967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:86 size:63858"} {"level":"warn","ts":"2026-05-27T13:49:03.524913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.080299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/\" range_end:\"/registry/serviceaccounts/kube-system0\" limit:500 ","response":"range_response_count:37 size:8042"} {"level":"info","ts":"2026-05-27T13:49:03.524915Z","caller":"traceutil/trace.go:171","msg":"trace[207739188] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:86; response_revision:1430; }","duration":"322.257318ms","start":"2026-05-27T13:49:03.202645Z","end":"2026-05-27T13:49:03.524903Z","steps":["trace[207739188] 'agreement among raft nodes before linearized reading' (duration: 321.665243ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:49:03.524912Z","caller":"traceutil/trace.go:171","msg":"trace[1979598962] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:1430; }","duration":"320.793967ms","start":"2026-05-27T13:49:03.204095Z","end":"2026-05-27T13:49:03.524889Z","steps":["trace[1979598962] 'agreement among raft nodes before linearized reading' (duration: 320.292323ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:49:03.524962Z","caller":"traceutil/trace.go:171","msg":"trace[1292399161] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/; range_end:/registry/serviceaccounts/kube-system0; response_count:37; response_revision:1430; }","duration":"295.16518ms","start":"2026-05-27T13:49:03.229782Z","end":"2026-05-27T13:49:03.524948Z","steps":["trace[1292399161] 'agreement among raft nodes before linearized reading' (duration: 294.886418ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:49:03.524973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:49:03.202639Z","time spent":"322.322098ms","remote":"127.0.0.1:51766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":86,"response size":63881,"request content":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 "} {"level":"warn","ts":"2026-05-27T13:49:03.524993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:49:03.204091Z","time spent":"320.877007ms","remote":"127.0.0.1:52158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":2941,"request content":"key:\"/registry/daemonsets/kube-system/kube-proxy\" "} {"level":"warn","ts":"2026-05-27T13:49:03.524574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.485059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/kube-system/\" range_end:\"/registry/services/specs/kube-system0\" limit:500 ","response":"range_response_count:1 size:1211"} {"level":"info","ts":"2026-05-27T13:49:03.525168Z","caller":"traceutil/trace.go:171","msg":"trace[687563287] range","detail":"{range_begin:/registry/services/specs/kube-system/; range_end:/registry/services/specs/kube-system0; response_count:1; response_revision:1430; }","duration":"247.108045ms","start":"2026-05-27T13:49:03.278041Z","end":"2026-05-27T13:49:03.525149Z","steps":["trace[687563287] 'agreement among raft nodes before linearized reading' (duration: 246.46141ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:49:03.524649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.014559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:49:03.525227Z","caller":"traceutil/trace.go:171","msg":"trace[1113072090] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1430; }","duration":"275.632554ms","start":"2026-05-27T13:49:03.249584Z","end":"2026-05-27T13:49:03.525217Z","steps":["trace[1113072090] 'agreement among raft nodes before linearized reading' (duration: 275.015238ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:49:03.525367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:49:03.201556Z","time spent":"323.167915ms","remote":"127.0.0.1:51928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:49:05.322114Z","caller":"traceutil/trace.go:171","msg":"trace[1500799159] transaction","detail":"{read_only:false; response_revision:1434; number_of_response:1; }","duration":"118.744602ms","start":"2026-05-27T13:49:05.203345Z","end":"2026-05-27T13:49:05.32209Z","steps":["trace[1500799159] 'process raft request' (duration: 118.489691ms)"],"step_count":1}