{"level":"warn","ts":"2026-05-27T15:36:11.515166Z","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-27T15:36:11.515285Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.25:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.25:2380","--initial-cluster=instance=https://199.19.213.25:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.25:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.25: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-27T15:36:11.515349Z","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-27T15:36:11.515361Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.25:2380"]} {"level":"info","ts":"2026-05-27T15:36:11.51538Z","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-27T15:36:11.515975Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.25:2379"]} {"level":"info","ts":"2026-05-27T15:36:11.516046Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.25:2380"],"listen-peer-urls":["https://199.19.213.25:2380"],"advertise-client-urls":["https://199.19.213.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.25: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-27T15:36:11.520448Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.216515ms"} {"level":"info","ts":"2026-05-27T15:36:11.527025Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9bd4db28c48efaf1","cluster-id":"b621f59192c78404"} {"level":"info","ts":"2026-05-27T15:36:11.527137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 switched to configuration voters=()"} {"level":"info","ts":"2026-05-27T15:36:11.527177Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became follower at term 0"} {"level":"info","ts":"2026-05-27T15:36:11.527203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9bd4db28c48efaf1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-27T15:36:11.527223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became follower at term 1"} {"level":"info","ts":"2026-05-27T15:36:11.527282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 switched to configuration voters=(11228840739084368625)"} {"level":"warn","ts":"2026-05-27T15:36:11.534976Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-27T15:36:11.536518Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-27T15:36:11.53761Z","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-27T15:36:11.539635Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9bd4db28c48efaf1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-27T15:36:11.539851Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9bd4db28c48efaf1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-27T15:36:11.539847Z","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-27T15:36:11.540195Z","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-27T15:36:11.540245Z","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-27T15:36:11.541079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 switched to configuration voters=(11228840739084368625)"} {"level":"info","ts":"2026-05-27T15:36:11.541194Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b621f59192c78404","local-member-id":"9bd4db28c48efaf1","added-peer-id":"9bd4db28c48efaf1","added-peer-peer-urls":["https://199.19.213.25:2380"]} {"level":"info","ts":"2026-05-27T15:36:11.545556Z","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-27T15:36:11.545854Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.25:2380"} {"level":"info","ts":"2026-05-27T15:36:11.545896Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.25:2380"} {"level":"info","ts":"2026-05-27T15:36:11.545958Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9bd4db28c48efaf1","initial-advertise-peer-urls":["https://199.19.213.25:2380"],"listen-peer-urls":["https://199.19.213.25:2380"],"advertise-client-urls":["https://199.19.213.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-27T15:36:11.546003Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-27T15:36:11.627927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 is starting a new election at term 1"} {"level":"info","ts":"2026-05-27T15:36:11.628004Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-27T15:36:11.628046Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 received MsgPreVoteResp from 9bd4db28c48efaf1 at term 1"} {"level":"info","ts":"2026-05-27T15:36:11.628073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became candidate at term 2"} {"level":"info","ts":"2026-05-27T15:36:11.628089Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 received MsgVoteResp from 9bd4db28c48efaf1 at term 2"} {"level":"info","ts":"2026-05-27T15:36:11.628112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became leader at term 2"} {"level":"info","ts":"2026-05-27T15:36:11.62813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9bd4db28c48efaf1 elected leader 9bd4db28c48efaf1 at term 2"} {"level":"info","ts":"2026-05-27T15:36:11.629161Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T15:36:11.629987Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T15:36:11.629985Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9bd4db28c48efaf1","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.25:2379]}","request-path":"/0/members/9bd4db28c48efaf1/attributes","cluster-id":"b621f59192c78404","publish-timeout":"7s"} {"level":"info","ts":"2026-05-27T15:36:11.630071Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T15:36:11.630329Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-27T15:36:11.630345Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-27T15:36:11.630392Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b621f59192c78404","local-member-id":"9bd4db28c48efaf1","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T15:36:11.630494Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T15:36:11.630528Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T15:36:11.631853Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.25:2379"} {"level":"info","ts":"2026-05-27T15:36:11.633058Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-27T15:36:17.998598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.875292ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-27T15:36:17.998719Z","caller":"traceutil/trace.go:171","msg":"trace[1823637212] linearizableReadLoop","detail":"{readStateIndex:271; appliedIndex:270; }","duration":"339.683491ms","start":"2026-05-27T15:36:17.659023Z","end":"2026-05-27T15:36:17.998707Z","steps":["trace[1823637212] 'read index received' (duration: 149.350697ms)","trace[1823637212] 'applied index is now lower than readState.Index' (duration: 190.331384ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T15:36:17.998762Z","caller":"traceutil/trace.go:171","msg":"trace[1546205097] transaction","detail":"{read_only:false; response_revision:263; number_of_response:1; }","duration":"366.334538ms","start":"2026-05-27T15:36:17.632389Z","end":"2026-05-27T15:36:17.998723Z","steps":["trace[1546205097] 'process raft request' (duration: 176.006994ms)","trace[1546205097] 'compare' (duration: 189.494032ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T15:36:17.998841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.810714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-27T15:36:17.998864Z","caller":"traceutil/trace.go:171","msg":"trace[1758472407] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:263; }","duration":"339.838916ms","start":"2026-05-27T15:36:17.659019Z","end":"2026-05-27T15:36:17.998858Z","steps":["trace[1758472407] 'agreement among raft nodes before linearized reading' (duration: 339.741283ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:36:17.998893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:36:17.658985Z","time spent":"339.902147ms","remote":"127.0.0.1:44586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":375,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-27T15:36:17.998898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:36:17.632372Z","time spent":"366.468402ms","remote":"127.0.0.1:44732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T15:36:18.152461Z","caller":"traceutil/trace.go:171","msg":"trace[1811651251] transaction","detail":"{read_only:false; number_of_response:0; response_revision:263; }","duration":"291.97703ms","start":"2026-05-27T15:36:17.860459Z","end":"2026-05-27T15:36:18.152436Z","steps":["trace[1811651251] 'process raft request' (duration: 291.855887ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:36:18.152458Z","caller":"traceutil/trace.go:171","msg":"trace[492945541] transaction","detail":"{read_only:false; number_of_response:0; response_revision:263; }","duration":"291.943879ms","start":"2026-05-27T15:36:17.860489Z","end":"2026-05-27T15:36:18.152433Z","steps":["trace[492945541] 'process raft request' (duration: 291.910167ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:36:18.398839Z","caller":"traceutil/trace.go:171","msg":"trace[489144502] transaction","detail":"{read_only:false; number_of_response:0; response_revision:263; }","duration":"538.260272ms","start":"2026-05-27T15:36:17.860528Z","end":"2026-05-27T15:36:18.398788Z","steps":["trace[489144502] 'process raft request' (duration: 538.069526ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:36:18.398861Z","caller":"traceutil/trace.go:171","msg":"trace[1016140242] linearizableReadLoop","detail":"{readStateIndex:275; appliedIndex:271; }","duration":"400.090711ms","start":"2026-05-27T15:36:17.998741Z","end":"2026-05-27T15:36:18.398831Z","steps":["trace[1016140242] 'read index received' (duration: 153.629444ms)","trace[1016140242] 'applied index is now lower than readState.Index' (duration: 246.460277ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T15:36:18.398857Z","caller":"traceutil/trace.go:171","msg":"trace[2023015035] transaction","detail":"{read_only:false; number_of_response:0; response_revision:263; }","duration":"537.86013ms","start":"2026-05-27T15:36:17.860962Z","end":"2026-05-27T15:36:18.398822Z","steps":["trace[2023015035] 'process raft request' (duration: 537.718897ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:36:18.398994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:36:17.860455Z","time spent":"538.473667ms","remote":"127.0.0.1:44644","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T15:36:18.399018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:36:17.860927Z","time spent":"538.030376ms","remote":"127.0.0.1:44644","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T15:36:18.39914Z","caller":"traceutil/trace.go:171","msg":"trace[1693201036] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"396.188665ms","start":"2026-05-27T15:36:18.002939Z","end":"2026-05-27T15:36:18.399127Z","steps":["trace[1693201036] 'process raft request' (duration: 395.849486ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:36:18.399128Z","caller":"traceutil/trace.go:171","msg":"trace[1059538107] transaction","detail":"{read_only:false; response_revision:264; number_of_response:1; }","duration":"397.104829ms","start":"2026-05-27T15:36:18.001995Z","end":"2026-05-27T15:36:18.399099Z","steps":["trace[1059538107] 'process raft request' (duration: 396.715418ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:36:18.399207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.082479ms","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-27T15:36:18.399221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.516102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3974"} {"level":"warn","ts":"2026-05-27T15:36:18.399229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:36:18.002926Z","time spent":"396.252367ms","remote":"127.0.0.1:44540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":705,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T15:36:18.399252Z","caller":"traceutil/trace.go:171","msg":"trace[1802185692] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:265; }","duration":"397.192922ms","start":"2026-05-27T15:36:18.002048Z","end":"2026-05-27T15:36:18.399241Z","steps":["trace[1802185692] 'agreement among raft nodes before linearized reading' (duration: 397.053868ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:36:18.399262Z","caller":"traceutil/trace.go:171","msg":"trace[326791709] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:265; }","duration":"245.583573ms","start":"2026-05-27T15:36:18.153664Z","end":"2026-05-27T15:36:18.399247Z","steps":["trace[326791709] 'agreement among raft nodes before linearized reading' (duration: 245.46978ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:36:18.399255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:36:18.001979Z","time spent":"397.221072ms","remote":"127.0.0.1:44662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T15:36:18.399282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:36:18.002037Z","time spent":"397.240313ms","remote":"127.0.0.1:44732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-27T15:36:18.399336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.695317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2920"} {"level":"info","ts":"2026-05-27T15:36:18.399443Z","caller":"traceutil/trace.go:171","msg":"trace[981656511] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:265; }","duration":"245.833411ms","start":"2026-05-27T15:36:18.153579Z","end":"2026-05-27T15:36:18.399413Z","steps":["trace[981656511] 'agreement among raft nodes before linearized reading' (duration: 245.596305ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:36:18.399561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.97406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3974"} {"level":"info","ts":"2026-05-27T15:36:18.399635Z","caller":"traceutil/trace.go:171","msg":"trace[1150310476] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:265; }","duration":"539.046973ms","start":"2026-05-27T15:36:17.860576Z","end":"2026-05-27T15:36:18.399623Z","steps":["trace[1150310476] 'agreement among raft nodes before linearized reading' (duration: 538.471247ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:36:18.399672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:36:17.860536Z","time spent":"539.128845ms","remote":"127.0.0.1:44644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":3998,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"warn","ts":"2026-05-27T15:36:18.602637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.357383ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T15:36:18.602755Z","caller":"traceutil/trace.go:171","msg":"trace[1278077485] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"196.551995ms","start":"2026-05-27T15:36:18.406185Z","end":"2026-05-27T15:36:18.602737Z","steps":["trace[1278077485] 'process raft request' (duration: 67.890033ms)","trace[1278077485] 'compare' (duration: 128.22861ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T15:36:18.618014Z","caller":"traceutil/trace.go:171","msg":"trace[250883159] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"208.978904ms","start":"2026-05-27T15:36:18.409002Z","end":"2026-05-27T15:36:18.617981Z","steps":["trace[250883159] 'process raft request' (duration: 208.684077ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:36:18.61816Z","caller":"traceutil/trace.go:171","msg":"trace[2017976236] transaction","detail":"{read_only:false; response_revision:268; number_of_response:1; }","duration":"184.375712ms","start":"2026-05-27T15:36:18.433767Z","end":"2026-05-27T15:36:18.618143Z","steps":["trace[2017976236] 'process raft request' (duration: 184.051743ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:36:38.983229Z","caller":"traceutil/trace.go:171","msg":"trace[74210387] linearizableReadLoop","detail":"{readStateIndex:558; appliedIndex:557; }","duration":"308.641014ms","start":"2026-05-27T15:36:38.674529Z","end":"2026-05-27T15:36:38.98317Z","steps":["trace[74210387] 'read index received' (duration: 307.930175ms)","trace[74210387] 'applied index is now lower than readState.Index' (duration: 709.659µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T15:36:38.983348Z","caller":"traceutil/trace.go:171","msg":"trace[1367014913] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"362.982438ms","start":"2026-05-27T15:36:38.620351Z","end":"2026-05-27T15:36:38.983333Z","steps":["trace[1367014913] 'process raft request' (duration: 362.128235ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:36:38.983497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:36:38.620326Z","time spent":"363.05417ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151212,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T15:36:38.983642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.088457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T15:36:38.983698Z","caller":"traceutil/trace.go:171","msg":"trace[862746513] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:538; }","duration":"309.182909ms","start":"2026-05-27T15:36:38.674502Z","end":"2026-05-27T15:36:38.983684Z","steps":["trace[862746513] 'agreement among raft nodes before linearized reading' (duration: 309.065396ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:36:38.983724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:36:38.674486Z","time spent":"309.23312ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "} {"level":"warn","ts":"2026-05-27T15:36:39.005682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.355077ms","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-27T15:36:39.005769Z","caller":"traceutil/trace.go:171","msg":"trace[1504997633] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:539; }","duration":"319.481641ms","start":"2026-05-27T15:36:38.686268Z","end":"2026-05-27T15:36:39.00575Z","steps":["trace[1504997633] 'agreement among raft nodes before linearized reading' (duration: 319.310125ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:36:39.005809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:36:38.686253Z","time spent":"319.547722ms","remote":"127.0.0.1:44732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-27T15:36:39.006235Z","caller":"traceutil/trace.go:171","msg":"trace[1756451555] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"170.74695ms","start":"2026-05-27T15:36:38.835468Z","end":"2026-05-27T15:36:39.006215Z","steps":["trace[1756451555] 'process raft request' (duration: 158.303031ms)","trace[1756451555] 'marshal mvccpb.KeyValue' {req_type:put; key:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; req_size:569090; } (duration: 11.69925ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T15:36:39.006485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.1393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T15:36:39.00652Z","caller":"traceutil/trace.go:171","msg":"trace[194512352] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:539; }","duration":"131.211781ms","start":"2026-05-27T15:36:38.875299Z","end":"2026-05-27T15:36:39.00651Z","steps":["trace[194512352] 'agreement among raft nodes before linearized reading' (duration: 131.16285ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:36:39.149592Z","caller":"traceutil/trace.go:171","msg":"trace[1760948147] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"124.322422ms","start":"2026-05-27T15:36:39.025232Z","end":"2026-05-27T15:36:39.149554Z","steps":["trace[1760948147] 'process raft request' (duration: 109.377595ms)","trace[1760948147] 'compare' (duration: 14.713321ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T15:36:39.151567Z","caller":"traceutil/trace.go:171","msg":"trace[1180168261] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"118.125164ms","start":"2026-05-27T15:36:39.03341Z","end":"2026-05-27T15:36:39.151535Z","steps":["trace[1180168261] 'process raft request' (duration: 117.855306ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:36:39.151739Z","caller":"traceutil/trace.go:171","msg":"trace[2117110247] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"118.208317ms","start":"2026-05-27T15:36:39.033523Z","end":"2026-05-27T15:36:39.151731Z","steps":["trace[2117110247] 'process raft request' (duration: 117.880908ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:36:44.378531Z","caller":"traceutil/trace.go:171","msg":"trace[1712669539] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"142.710745ms","start":"2026-05-27T15:36:44.235796Z","end":"2026-05-27T15:36:44.378507Z","steps":["trace[1712669539] 'process raft request' (duration: 141.967054ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:36:46.431259Z","caller":"traceutil/trace.go:171","msg":"trace[1587168390] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"489.757478ms","start":"2026-05-27T15:36:45.94147Z","end":"2026-05-27T15:36:46.431228Z","steps":["trace[1587168390] 'process raft request' (duration: 489.511632ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:36:46.431424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:36:45.94145Z","time spent":"489.895702ms","remote":"127.0.0.1:44644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T15:37:04.153928Z","caller":"traceutil/trace.go:171","msg":"trace[686851227] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"110.010612ms","start":"2026-05-27T15:37:04.043888Z","end":"2026-05-27T15:37:04.153899Z","steps":["trace[686851227] 'process raft request' (duration: 109.847898ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:37:39.289548Z","caller":"traceutil/trace.go:171","msg":"trace[934373589] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"102.584891ms","start":"2026-05-27T15:37:39.186939Z","end":"2026-05-27T15:37:39.289524Z","steps":["trace[934373589] 'process raft request' (duration: 102.424046ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:37:40.879677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.592681ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"warn","ts":"2026-05-27T15:37:40.879688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.251641ms","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-27T15:37:40.879765Z","caller":"traceutil/trace.go:171","msg":"trace[1749583420] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:963; }","duration":"291.332463ms","start":"2026-05-27T15:37:40.58842Z","end":"2026-05-27T15:37:40.879752Z","steps":["trace[1749583420] 'range keys from in-memory index tree' (duration: 291.239111ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:37:40.879769Z","caller":"traceutil/trace.go:171","msg":"trace[577207546] linearizableReadLoop","detail":"{readStateIndex:998; appliedIndex:997; }","duration":"396.36046ms","start":"2026-05-27T15:37:40.483395Z","end":"2026-05-27T15:37:40.879755Z","steps":["trace[577207546] 'read index received' (duration: 34.241µs)","trace[577207546] 'applied index is now lower than readState.Index' (duration: 396.324999ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T15:37:40.8799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.498244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T15:37:40.879928Z","caller":"traceutil/trace.go:171","msg":"trace[110877303] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:963; }","duration":"396.555936ms","start":"2026-05-27T15:37:40.483362Z","end":"2026-05-27T15:37:40.879918Z","steps":["trace[110877303] 'agreement among raft nodes before linearized reading' (duration: 396.503634ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:37:40.879961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:37:40.483344Z","time spent":"396.609217ms","remote":"127.0.0.1:44482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-27T15:37:41.498102Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18082408157312454448,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T15:37:41.998527Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18082408157312454448,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T15:37:42.498965Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18082408157312454448,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T15:37:42.999493Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18082408157312454448,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T15:37:43.499994Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18082408157312454448,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T15:37:43.65693Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.737704243s","expected-duration":"1s"} {"level":"info","ts":"2026-05-27T15:37:43.657852Z","caller":"traceutil/trace.go:171","msg":"trace[774429170] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"2.772689203s","start":"2026-05-27T15:37:40.884872Z","end":"2026-05-27T15:37:43.657561Z","steps":["trace[774429170] 'process raft request' (duration: 2.77252978s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:37:43.657975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:37:40.884856Z","time spent":"2.773055375s","remote":"127.0.0.1:44732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T15:37:44.436624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000370907s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-27T15:37:44.436688Z","caller":"traceutil/trace.go:171","msg":"trace[761310685] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000479322s","start":"2026-05-27T15:37:42.436194Z","end":"2026-05-27T15:37:44.436673Z","steps":["trace[761310685] 'agreement among raft nodes before linearized reading' (duration: 2.000396259s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:37:44.436722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:37:42.436179Z","time spent":"2.000537853s","remote":"127.0.0.1:44482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-27T15:37:44.483925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000323677s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-27T15:37:44.484071Z","caller":"traceutil/trace.go:171","msg":"trace[596937748] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000508791s","start":"2026-05-27T15:37:42.483543Z","end":"2026-05-27T15:37:44.484052Z","steps":["trace[596937748] 'agreement among raft nodes before linearized reading' (duration: 2.000343996s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:37:44.484147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:37:42.483531Z","time spent":"2.000604143s","remote":"127.0.0.1:44496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/27 15:37:44 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-27T15:37:44.776874Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.119741466s","expected-duration":"1s"} {"level":"info","ts":"2026-05-27T15:37:44.777227Z","caller":"traceutil/trace.go:171","msg":"trace[1009045600] linearizableReadLoop","detail":"{readStateIndex:1000; appliedIndex:998; }","duration":"3.779873448s","start":"2026-05-27T15:37:40.997337Z","end":"2026-05-27T15:37:44.77721Z","steps":["trace[1009045600] 'read index received' (duration: 2.660011479s)","trace[1009045600] 'applied index is now lower than readState.Index' (duration: 1.119861259s)"],"step_count":2} {"level":"info","ts":"2026-05-27T15:37:44.777301Z","caller":"traceutil/trace.go:171","msg":"trace[553868100] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"3.771517161s","start":"2026-05-27T15:37:41.005752Z","end":"2026-05-27T15:37:44.77727Z","steps":["trace[553868100] 'process raft request' (duration: 3.771238564s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:37:44.77732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.77996941s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T15:37:44.777429Z","caller":"traceutil/trace.go:171","msg":"trace[1857060450] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:965; }","duration":"3.780123546s","start":"2026-05-27T15:37:40.997297Z","end":"2026-05-27T15:37:44.777421Z","steps":["trace[1857060450] 'agreement among raft nodes before linearized reading' (duration: 3.779974491s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:37:44.777447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:37:41.00574Z","time spent":"3.771636494s","remote":"127.0.0.1:44732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T15:37:44.77746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:37:40.997281Z","time spent":"3.780171536s","remote":"127.0.0.1:45004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":29,"response size":31,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"warn","ts":"2026-05-27T15:37:44.805038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.409170315s","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-27T15:37:44.805073Z","caller":"traceutil/trace.go:171","msg":"trace[205094069] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:966; }","duration":"3.409239887s","start":"2026-05-27T15:37:41.395824Z","end":"2026-05-27T15:37:44.805064Z","steps":["trace[205094069] 'agreement among raft nodes before linearized reading' (duration: 3.409120504s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:37:44.805094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:37:41.395807Z","time spent":"3.409281968s","remote":"127.0.0.1:44732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-27T15:37:44.805082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.660221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T15:37:44.805146Z","caller":"traceutil/trace.go:171","msg":"trace[769188427] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:966; }","duration":"313.767323ms","start":"2026-05-27T15:37:44.491364Z","end":"2026-05-27T15:37:44.805132Z","steps":["trace[769188427] 'agreement among raft nodes before linearized reading' (duration: 313.617659ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:37:44.805154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.221135191s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-27T15:37:44.805182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:37:44.491349Z","time spent":"313.827817ms","remote":"127.0.0.1:44482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-27T15:37:44.805213Z","caller":"traceutil/trace.go:171","msg":"trace[1891020934] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:966; }","duration":"3.221230994s","start":"2026-05-27T15:37:41.583965Z","end":"2026-05-27T15:37:44.805196Z","steps":["trace[1891020934] 'agreement among raft nodes before linearized reading' (duration: 3.221042089s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:37:44.805226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:37:44.439614Z","time spent":"365.607975ms","remote":"127.0.0.1:44540","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-27T15:37:44.805242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.273069824s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-27T15:37:44.805266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:37:41.583947Z","time spent":"3.221301565s","remote":"127.0.0.1:44732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-27T15:37:44.805282Z","caller":"traceutil/trace.go:171","msg":"trace[661514414] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:966; }","duration":"3.273116505s","start":"2026-05-27T15:37:41.532155Z","end":"2026-05-27T15:37:44.805271Z","steps":["trace[661514414] 'agreement among raft nodes before linearized reading' (duration: 3.273033713s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:37:44.805269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.165219589s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-27T15:37:44.805295Z","caller":"traceutil/trace.go:171","msg":"trace[1052387904] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"162.042998ms","start":"2026-05-27T15:37:44.643244Z","end":"2026-05-27T15:37:44.805287Z","steps":["trace[1052387904] 'process raft request' (duration: 161.653507ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:37:44.805307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:37:41.532135Z","time spent":"3.273165846s","remote":"127.0.0.1:44900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":31,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-05-27T15:37:44.805274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.147423378s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T15:37:44.805331Z","caller":"traceutil/trace.go:171","msg":"trace[308410186] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:966; }","duration":"3.165318233s","start":"2026-05-27T15:37:41.639995Z","end":"2026-05-27T15:37:44.805314Z","steps":["trace[308410186] 'agreement among raft nodes before linearized reading' (duration: 3.16518142s)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:37:44.805362Z","caller":"traceutil/trace.go:171","msg":"trace[1073164174] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:966; }","duration":"1.147578943s","start":"2026-05-27T15:37:43.657764Z","end":"2026-05-27T15:37:44.805343Z","steps":["trace[1073164174] 'agreement among raft nodes before linearized reading' (duration: 1.147389268s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:37:44.805386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:37:41.639973Z","time spent":"3.165397175s","remote":"127.0.0.1:44732","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-27T15:37:44.805412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:37:43.657744Z","time spent":"1.147657175s","remote":"127.0.0.1:44606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-05-27T15:37:44.805425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.336516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T15:37:44.805451Z","caller":"traceutil/trace.go:171","msg":"trace[69987973] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:966; }","duration":"158.393039ms","start":"2026-05-27T15:37:44.647051Z","end":"2026-05-27T15:37:44.805444Z","steps":["trace[69987973] 'agreement among raft nodes before linearized reading' (duration: 158.320226ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:37:44.805725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.269121525s","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-27T15:37:44.805829Z","caller":"traceutil/trace.go:171","msg":"trace[1258433041] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:966; }","duration":"3.269269719s","start":"2026-05-27T15:37:41.536543Z","end":"2026-05-27T15:37:44.805813Z","steps":["trace[1258433041] 'agreement among raft nodes before linearized reading' (duration: 3.26852878s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:37:44.80588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:37:41.53653Z","time spent":"3.269336792s","remote":"127.0.0.1:44732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-27T15:37:45.873768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.024378401s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-27T15:37:45.873861Z","caller":"traceutil/trace.go:171","msg":"trace[1503777256] linearizableReadLoop","detail":"{readStateIndex:1003; appliedIndex:1002; }","duration":"1.06732722s","start":"2026-05-27T15:37:44.806519Z","end":"2026-05-27T15:37:45.873846Z","steps":["trace[1503777256] 'read index received' (duration: 42.793044ms)","trace[1503777256] 'applied index is now lower than readState.Index' (duration: 1.024532686s)"],"step_count":2} {"level":"info","ts":"2026-05-27T15:37:45.873917Z","caller":"traceutil/trace.go:171","msg":"trace[1688939367] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"1.067572156s","start":"2026-05-27T15:37:44.806336Z","end":"2026-05-27T15:37:45.873908Z","steps":["trace[1688939367] 'process raft request' (duration: 43.00982ms)","trace[1688939367] 'compare' (duration: 1.024224007s)"],"step_count":2} {"level":"warn","ts":"2026-05-27T15:37:45.873961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:37:44.806321Z","time spent":"1.067616669s","remote":"127.0.0.1:44540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":758,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T15:37:45.874211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.067681979s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T15:37:45.874248Z","caller":"traceutil/trace.go:171","msg":"trace[1776714558] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:967; }","duration":"1.06773573s","start":"2026-05-27T15:37:44.806503Z","end":"2026-05-27T15:37:45.874239Z","steps":["trace[1776714558] 'agreement among raft nodes before linearized reading' (duration: 1.067640967s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:37:45.874274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:37:44.806497Z","time spent":"1.067771222s","remote":"127.0.0.1:44496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-27T15:37:45.943606Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.094329224s","expected-duration":"1s"} {"level":"info","ts":"2026-05-27T15:37:45.943897Z","caller":"traceutil/trace.go:171","msg":"trace[1111229649] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"1.13496712s","start":"2026-05-27T15:37:44.808911Z","end":"2026-05-27T15:37:45.943878Z","steps":["trace[1111229649] 'process raft request' (duration: 1.134822486s)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:37:45.943905Z","caller":"traceutil/trace.go:171","msg":"trace[902034909] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"1.134651571s","start":"2026-05-27T15:37:44.809236Z","end":"2026-05-27T15:37:45.943887Z","steps":["trace[902034909] 'process raft request' (duration: 1.13461211s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:37:45.943991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:37:44.808876Z","time spent":"1.135055612s","remote":"127.0.0.1:44732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T15:37:45.94402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:37:44.809225Z","time spent":"1.134736294s","remote":"127.0.0.1:44732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T15:37:45.944003Z","caller":"traceutil/trace.go:171","msg":"trace[1443945200] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"1.135030171s","start":"2026-05-27T15:37:44.808945Z","end":"2026-05-27T15:37:45.943975Z","steps":["trace[1443945200] 'process raft request' (duration: 1.134881317s)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:37:45.944095Z","caller":"traceutil/trace.go:171","msg":"trace[1638896724] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"1.134690182s","start":"2026-05-27T15:37:44.809398Z","end":"2026-05-27T15:37:45.944088Z","steps":["trace[1638896724] 'process raft request' (duration: 1.134468636s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:37:45.944137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"842.093063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T15:37:45.944165Z","caller":"traceutil/trace.go:171","msg":"trace[1817860945] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:971; }","duration":"842.155506ms","start":"2026-05-27T15:37:45.102002Z","end":"2026-05-27T15:37:45.944158Z","steps":["trace[1817860945] 'agreement among raft nodes before linearized reading' (duration: 842.111794ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:37:45.944185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:37:45.101984Z","time spent":"842.195436ms","remote":"127.0.0.1:44640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":31,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"warn","ts":"2026-05-27T15:37:45.944191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.949756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-27T15:37:45.944212Z","caller":"traceutil/trace.go:171","msg":"trace[1527227987] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:971; }","duration":"282.994247ms","start":"2026-05-27T15:37:45.661211Z","end":"2026-05-27T15:37:45.944206Z","steps":["trace[1527227987] 'agreement among raft nodes before linearized reading' (duration: 282.912195ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:37:45.944236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:37:44.808933Z","time spent":"1.135143495s","remote":"127.0.0.1:44732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T15:37:45.94425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"941.004453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.25\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-05-27T15:37:45.944285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.651764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T15:37:45.944305Z","caller":"traceutil/trace.go:171","msg":"trace[1885557098] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:971; }","duration":"462.707445ms","start":"2026-05-27T15:37:45.481593Z","end":"2026-05-27T15:37:45.9443Z","steps":["trace[1885557098] 'agreement among raft nodes before linearized reading' (duration: 462.479919ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:37:45.944297Z","caller":"traceutil/trace.go:171","msg":"trace[136250416] range","detail":"{range_begin:/registry/masterleases/199.19.213.25; range_end:; response_count:1; response_revision:971; }","duration":"941.089367ms","start":"2026-05-27T15:37:45.003195Z","end":"2026-05-27T15:37:45.944284Z","steps":["trace[136250416] 'agreement among raft nodes before linearized reading' (duration: 940.968454ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:37:45.944324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:37:45.48155Z","time spent":"462.768986ms","remote":"127.0.0.1:44886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":31,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-05-27T15:37:45.944332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:37:45.003174Z","time spent":"941.150058ms","remote":"127.0.0.1:44504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.25\" "} {"level":"warn","ts":"2026-05-27T15:37:45.944396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:37:44.80939Z","time spent":"1.134721733s","remote":"127.0.0.1:44732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T15:37:46.068045Z","caller":"traceutil/trace.go:171","msg":"trace[1443012503] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"190.219634ms","start":"2026-05-27T15:37:45.877793Z","end":"2026-05-27T15:37:46.068013Z","steps":["trace[1443012503] 'process raft request' (duration: 141.869229ms)","trace[1443012503] 'compare' (duration: 48.209321ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T15:37:46.068466Z","caller":"traceutil/trace.go:171","msg":"trace[1972798593] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"119.932811ms","start":"2026-05-27T15:37:45.948497Z","end":"2026-05-27T15:37:46.06843Z","steps":["trace[1972798593] 'process raft request' (duration: 119.541511ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:37:46.068484Z","caller":"traceutil/trace.go:171","msg":"trace[1851805179] linearizableReadLoop","detail":"{readStateIndex:1008; appliedIndex:1007; }","duration":"124.071725ms","start":"2026-05-27T15:37:45.944032Z","end":"2026-05-27T15:37:46.068104Z","steps":["trace[1851805179] 'read index received' (duration: 75.609677ms)","trace[1851805179] 'applied index is now lower than readState.Index' (duration: 48.458868ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T15:37:46.068594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.053051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T15:37:46.068658Z","caller":"traceutil/trace.go:171","msg":"trace[1425269313] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:973; }","duration":"186.136193ms","start":"2026-05-27T15:37:45.882499Z","end":"2026-05-27T15:37:46.068635Z","steps":["trace[1425269313] 'agreement among raft nodes before linearized reading' (duration: 185.859316ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:37:54.42121Z","caller":"traceutil/trace.go:171","msg":"trace[2004762384] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"136.02551ms","start":"2026-05-27T15:37:54.285158Z","end":"2026-05-27T15:37:54.421184Z","steps":["trace[2004762384] 'process raft request' (duration: 59.452377ms)","trace[2004762384] 'compare' (duration: 76.148701ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T15:38:05.14891Z","caller":"traceutil/trace.go:171","msg":"trace[1197397928] linearizableReadLoop","detail":"{readStateIndex:1073; appliedIndex:1072; }","duration":"145.195629ms","start":"2026-05-27T15:38:05.003691Z","end":"2026-05-27T15:38:05.148887Z","steps":["trace[1197397928] 'read index received' (duration: 145.019214ms)","trace[1197397928] 'applied index is now lower than readState.Index' (duration: 175.125µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T15:38:05.148997Z","caller":"traceutil/trace.go:171","msg":"trace[35710553] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"193.523013ms","start":"2026-05-27T15:38:04.955441Z","end":"2026-05-27T15:38:05.148964Z","steps":["trace[35710553] 'process raft request' (duration: 193.278076ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:38:05.149188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.416794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.25\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-27T15:38:05.149233Z","caller":"traceutil/trace.go:171","msg":"trace[519926451] range","detail":"{range_begin:/registry/masterleases/199.19.213.25; range_end:; response_count:1; response_revision:1033; }","duration":"145.58971ms","start":"2026-05-27T15:38:05.003633Z","end":"2026-05-27T15:38:05.149223Z","steps":["trace[519926451] 'agreement among raft nodes before linearized reading' (duration: 145.343313ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:38:06.301693Z","caller":"traceutil/trace.go:171","msg":"trace[1711135286] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"106.305091ms","start":"2026-05-27T15:38:06.195347Z","end":"2026-05-27T15:38:06.301652Z","steps":["trace[1711135286] 'process raft request' (duration: 106.071895ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:38:06.527985Z","caller":"traceutil/trace.go:171","msg":"trace[1622461660] linearizableReadLoop","detail":"{readStateIndex:1078; appliedIndex:1077; }","duration":"157.152804ms","start":"2026-05-27T15:38:06.370807Z","end":"2026-05-27T15:38:06.52796Z","steps":["trace[1622461660] 'read index received' (duration: 94.833269ms)","trace[1622461660] 'applied index is now lower than readState.Index' (duration: 62.318135ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T15:38:06.528142Z","caller":"traceutil/trace.go:171","msg":"trace[272845002] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"221.700581ms","start":"2026-05-27T15:38:06.306411Z","end":"2026-05-27T15:38:06.528112Z","steps":["trace[272845002] 'process raft request' (duration: 159.224741ms)","trace[272845002] 'compare' (duration: 62.058348ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T15:38:06.528333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.524785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-27T15:38:06.528429Z","caller":"traceutil/trace.go:171","msg":"trace[1363994541] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1037; }","duration":"157.668508ms","start":"2026-05-27T15:38:06.370744Z","end":"2026-05-27T15:38:06.528413Z","steps":["trace[1363994541] 'agreement among raft nodes before linearized reading' (duration: 157.437201ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:38:06.528771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.010119ms","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-27T15:38:06.528856Z","caller":"traceutil/trace.go:171","msg":"trace[650449617] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1037; }","duration":"129.149124ms","start":"2026-05-27T15:38:06.399688Z","end":"2026-05-27T15:38:06.528838Z","steps":["trace[650449617] 'agreement among raft nodes before linearized reading' (duration: 128.908367ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:38:23.688407Z","caller":"traceutil/trace.go:171","msg":"trace[2072566091] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"393.270687ms","start":"2026-05-27T15:38:23.295114Z","end":"2026-05-27T15:38:23.688384Z","steps":["trace[2072566091] 'process raft request' (duration: 393.138442ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:38:23.688586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:38:23.295094Z","time spent":"393.39798ms","remote":"127.0.0.1:44732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T15:38:23.688869Z","caller":"traceutil/trace.go:171","msg":"trace[883471245] linearizableReadLoop","detail":"{readStateIndex:1190; appliedIndex:1190; }","duration":"159.279573ms","start":"2026-05-27T15:38:23.529547Z","end":"2026-05-27T15:38:23.688826Z","steps":["trace[883471245] 'read index received' (duration: 159.268873ms)","trace[883471245] 'applied index is now lower than readState.Index' (duration: 8.38µs)"],"step_count":2} {"level":"warn","ts":"2026-05-27T15:38:23.689043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.444037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T15:38:23.68908Z","caller":"traceutil/trace.go:171","msg":"trace[1594786731] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1145; }","duration":"159.56109ms","start":"2026-05-27T15:38:23.529507Z","end":"2026-05-27T15:38:23.689068Z","steps":["trace[1594786731] 'agreement among raft nodes before linearized reading' (duration: 159.437247ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:38:36.824906Z","caller":"traceutil/trace.go:171","msg":"trace[1040135198] linearizableReadLoop","detail":"{readStateIndex:1236; appliedIndex:1235; }","duration":"117.759463ms","start":"2026-05-27T15:38:36.70713Z","end":"2026-05-27T15:38:36.824889Z","steps":["trace[1040135198] 'read index received' (duration: 117.64635ms)","trace[1040135198] 'applied index is now lower than readState.Index' (duration: 112.413µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T15:38:36.824952Z","caller":"traceutil/trace.go:171","msg":"trace[850535497] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"167.756992ms","start":"2026-05-27T15:38:36.65717Z","end":"2026-05-27T15:38:36.824927Z","steps":["trace[850535497] 'process raft request' (duration: 167.594678ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:38:36.825105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.944887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-27T15:38:36.825131Z","caller":"traceutil/trace.go:171","msg":"trace[155058882] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1188; }","duration":"118.02721ms","start":"2026-05-27T15:38:36.707096Z","end":"2026-05-27T15:38:36.825123Z","steps":["trace[155058882] 'agreement among raft nodes before linearized reading' (duration: 117.896867ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:38:36.825205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.330759ms","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-27T15:38:36.825275Z","caller":"traceutil/trace.go:171","msg":"trace[1172308390] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1188; }","duration":"103.442071ms","start":"2026-05-27T15:38:36.721818Z","end":"2026-05-27T15:38:36.82526Z","steps":["trace[1172308390] 'agreement among raft nodes before linearized reading' (duration: 103.241066ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:38:38.382984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.861346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T15:38:38.383077Z","caller":"traceutil/trace.go:171","msg":"trace[201576537] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1201; }","duration":"309.018699ms","start":"2026-05-27T15:38:38.07404Z","end":"2026-05-27T15:38:38.383059Z","steps":["trace[201576537] 'count revisions from in-memory index tree' (duration: 308.758142ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:38:38.383066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.764259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T15:38:38.383121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:38:38.07402Z","time spent":"309.090962ms","remote":"127.0.0.1:44704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"info","ts":"2026-05-27T15:38:38.383142Z","caller":"traceutil/trace.go:171","msg":"trace[612727153] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1201; }","duration":"168.890473ms","start":"2026-05-27T15:38:38.214232Z","end":"2026-05-27T15:38:38.383122Z","steps":["trace[612727153] 'count revisions from in-memory index tree' (duration: 168.679728ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:38:38.383268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.699079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T15:38:38.383344Z","caller":"traceutil/trace.go:171","msg":"trace[2092005667] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1201; }","duration":"144.810171ms","start":"2026-05-27T15:38:38.238514Z","end":"2026-05-27T15:38:38.383325Z","steps":["trace[2092005667] 'range keys from in-memory index tree' (duration: 144.596867ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:38:42.749225Z","caller":"traceutil/trace.go:171","msg":"trace[1171367318] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"208.665672ms","start":"2026-05-27T15:38:42.540538Z","end":"2026-05-27T15:38:42.749203Z","steps":["trace[1171367318] 'process raft request' (duration: 208.544999ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:38:43.119108Z","caller":"traceutil/trace.go:171","msg":"trace[1558277298] linearizableReadLoop","detail":"{readStateIndex:1309; appliedIndex:1308; }","duration":"365.41484ms","start":"2026-05-27T15:38:42.753661Z","end":"2026-05-27T15:38:43.119076Z","steps":["trace[1558277298] 'read index received' (duration: 302.492517ms)","trace[1558277298] 'applied index is now lower than readState.Index' (duration: 62.920833ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T15:38:43.119146Z","caller":"traceutil/trace.go:171","msg":"trace[564241213] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"524.918063ms","start":"2026-05-27T15:38:42.594196Z","end":"2026-05-27T15:38:43.119114Z","steps":["trace[564241213] 'process raft request' (duration: 461.940127ms)","trace[564241213] 'compare' (duration: 62.78334ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T15:38:43.119399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.709768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"warn","ts":"2026-05-27T15:38:43.119419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:38:42.594174Z","time spent":"525.184641ms","remote":"127.0.0.1:44540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T15:38:43.119476Z","caller":"traceutil/trace.go:171","msg":"trace[1581391192] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1260; }","duration":"365.819181ms","start":"2026-05-27T15:38:42.753624Z","end":"2026-05-27T15:38:43.119443Z","steps":["trace[1581391192] 'agreement among raft nodes before linearized reading' (duration: 365.624226ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:38:43.119536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:38:42.753607Z","time spent":"365.913783ms","remote":"127.0.0.1:44732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":559,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-05-27T15:38:43.133748Z","caller":"traceutil/trace.go:171","msg":"trace[92550014] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"377.145303ms","start":"2026-05-27T15:38:42.756584Z","end":"2026-05-27T15:38:43.133729Z","steps":["trace[92550014] 'process raft request' (duration: 376.883336ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:38:43.133815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.985512ms","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-27T15:38:43.133862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:38:42.756558Z","time spent":"377.243875ms","remote":"127.0.0.1:44540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":929,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T15:38:43.133854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.7172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-27T15:38:43.133879Z","caller":"traceutil/trace.go:171","msg":"trace[2045467647] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1261; }","duration":"276.080414ms","start":"2026-05-27T15:38:42.857784Z","end":"2026-05-27T15:38:43.133865Z","steps":["trace[2045467647] 'agreement among raft nodes before linearized reading' (duration: 275.846387ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:38:43.133816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.229658ms","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-27T15:38:43.133991Z","caller":"traceutil/trace.go:171","msg":"trace[1015596684] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1261; }","duration":"282.445544ms","start":"2026-05-27T15:38:42.851522Z","end":"2026-05-27T15:38:43.133967Z","steps":["trace[1015596684] 'agreement among raft nodes before linearized reading' (duration: 282.090504ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:38:43.133916Z","caller":"traceutil/trace.go:171","msg":"trace[1489936319] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1261; }","duration":"276.817133ms","start":"2026-05-27T15:38:42.857085Z","end":"2026-05-27T15:38:43.133902Z","steps":["trace[1489936319] 'agreement among raft nodes before linearized reading' (duration: 276.626837ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:38:43.134278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.630098ms","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-27T15:38:43.134321Z","caller":"traceutil/trace.go:171","msg":"trace[1074110403] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1261; }","duration":"276.713362ms","start":"2026-05-27T15:38:42.857597Z","end":"2026-05-27T15:38:43.134311Z","steps":["trace[1074110403] 'agreement among raft nodes before linearized reading' (duration: 276.053944ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:38:52.92774Z","caller":"traceutil/trace.go:171","msg":"trace[1062929918] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"396.549648ms","start":"2026-05-27T15:38:52.531164Z","end":"2026-05-27T15:38:52.927714Z","steps":["trace[1062929918] 'process raft request' (duration: 396.412775ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:38:52.92791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T15:38:52.531144Z","time spent":"396.672441ms","remote":"127.0.0.1:44732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T15:38:53.491997Z","caller":"traceutil/trace.go:171","msg":"trace[924816317] linearizableReadLoop","detail":"{readStateIndex:1385; appliedIndex:1384; }","duration":"244.653058ms","start":"2026-05-27T15:38:53.247331Z","end":"2026-05-27T15:38:53.491984Z","steps":["trace[924816317] 'read index received' (duration: 164.68383ms)","trace[924816317] 'applied index is now lower than readState.Index' (duration: 79.968258ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T15:38:53.492272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.896718ms","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-27T15:38:53.492298Z","caller":"traceutil/trace.go:171","msg":"trace[847277934] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1333; }","duration":"243.96827ms","start":"2026-05-27T15:38:53.248324Z","end":"2026-05-27T15:38:53.492293Z","steps":["trace[847277934] 'agreement among raft nodes before linearized reading' (duration: 243.888748ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:38:53.492436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.528798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-27T15:38:53.492452Z","caller":"traceutil/trace.go:171","msg":"trace[1060113045] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1333; }","duration":"243.561898ms","start":"2026-05-27T15:38:53.248886Z","end":"2026-05-27T15:38:53.492448Z","steps":["trace[1060113045] 'agreement among raft nodes before linearized reading' (duration: 243.514817ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:38:53.492427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.078959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-27T15:38:53.492142Z","caller":"traceutil/trace.go:171","msg":"trace[1111486879] transaction","detail":"{read_only:false; response_revision:1333; number_of_response:1; }","duration":"283.213662ms","start":"2026-05-27T15:38:53.208918Z","end":"2026-05-27T15:38:53.492132Z","steps":["trace[1111486879] 'process raft request' (duration: 203.02014ms)","trace[1111486879] 'compare' (duration: 79.72105ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T15:38:53.492515Z","caller":"traceutil/trace.go:171","msg":"trace[1486685672] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1333; }","duration":"245.213843ms","start":"2026-05-27T15:38:53.247283Z","end":"2026-05-27T15:38:53.492497Z","steps":["trace[1486685672] 'agreement among raft nodes before linearized reading' (duration: 244.959715ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T15:38:53.492548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.154554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-27T15:38:53.492599Z","caller":"traceutil/trace.go:171","msg":"trace[761743953] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1333; }","duration":"244.206066ms","start":"2026-05-27T15:38:53.248377Z","end":"2026-05-27T15:38:53.492583Z","steps":["trace[761743953] 'agreement among raft nodes before linearized reading' (duration: 244.065692ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:38:53.692322Z","caller":"traceutil/trace.go:171","msg":"trace[155912218] transaction","detail":"{read_only:false; response_revision:1337; number_of_response:1; }","duration":"195.484631ms","start":"2026-05-27T15:38:53.496813Z","end":"2026-05-27T15:38:53.692298Z","steps":["trace[155912218] 'process raft request' (duration: 195.4365ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:38:53.692381Z","caller":"traceutil/trace.go:171","msg":"trace[885410514] transaction","detail":"{read_only:false; response_revision:1336; number_of_response:1; }","duration":"195.752487ms","start":"2026-05-27T15:38:53.496575Z","end":"2026-05-27T15:38:53.692327Z","steps":["trace[885410514] 'process raft request' (duration: 195.536971ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T15:39:01.348097Z","caller":"traceutil/trace.go:171","msg":"trace[1447519780] linearizableReadLoop","detail":"{readStateIndex:1430; appliedIndex:1429; }","duration":"108.497486ms","start":"2026-05-27T15:39:01.23957Z","end":"2026-05-27T15:39:01.348068Z","steps":["trace[1447519780] 'read index received' (duration: 69.868308ms)","trace[1447519780] 'applied index is now lower than readState.Index' (duration: 38.627768ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T15:39:01.348119Z","caller":"traceutil/trace.go:171","msg":"trace[879329124] transaction","detail":"{read_only:false; response_revision:1376; number_of_response:1; }","duration":"193.784975ms","start":"2026-05-27T15:39:01.154311Z","end":"2026-05-27T15:39:01.348096Z","steps":["trace[879329124] 'process raft request' (duration: 155.071384ms)","trace[879329124] 'compare' (duration: 38.430013ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T15:39:01.348381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.797814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-05-27T15:39:01.348422Z","caller":"traceutil/trace.go:171","msg":"trace[438903466] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1376; }","duration":"108.855266ms","start":"2026-05-27T15:39:01.239556Z","end":"2026-05-27T15:39:01.348411Z","steps":["trace[438903466] 'agreement among raft nodes before linearized reading' (duration: 108.665001ms)"],"step_count":1}