{"level":"warn","ts":"2026-05-16T09:20:08.126756Z","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-16T09:20:08.126844Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.115: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.115:2380","--initial-cluster=instance=https://199.204.45.115:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.115:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.115: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-16T09:20:08.126929Z","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-16T09:20:08.126942Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.115:2380"]}
{"level":"info","ts":"2026-05-16T09:20:08.12696Z","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-16T09:20:08.127581Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"]}
{"level":"info","ts":"2026-05-16T09:20:08.127651Z","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.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.115: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-16T09:20:08.131314Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.46644ms"}
{"level":"info","ts":"2026-05-16T09:20:08.136306Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e3aaa5c123e150e0","cluster-id":"61ec519698823541"}
{"level":"info","ts":"2026-05-16T09:20:08.13636Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-16T09:20:08.136379Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 0"}
{"level":"info","ts":"2026-05-16T09:20:08.136387Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e3aaa5c123e150e0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-16T09:20:08.136396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 1"}
{"level":"info","ts":"2026-05-16T09:20:08.136424Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"}
{"level":"warn","ts":"2026-05-16T09:20:08.142372Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-16T09:20:08.14371Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-16T09:20:08.145515Z","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-16T09:20:08.147491Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e3aaa5c123e150e0","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-16T09:20:08.147666Z","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-16T09:20:08.147792Z","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-16T09:20:08.147813Z","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-16T09:20:08.148218Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e3aaa5c123e150e0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-16T09:20:08.150824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"}
{"level":"info","ts":"2026-05-16T09:20:08.150938Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","added-peer-id":"e3aaa5c123e150e0","added-peer-peer-urls":["https://199.204.45.115:2380"]}
{"level":"info","ts":"2026-05-16T09:20:08.152933Z","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-16T09:20:08.153109Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e3aaa5c123e150e0","initial-advertise-peer-urls":["https://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-16T09:20:08.153136Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-16T09:20:08.15324Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.115:2380"}
{"level":"info","ts":"2026-05-16T09:20:08.153255Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.115:2380"}
{"level":"info","ts":"2026-05-16T09:20:09.137006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-16T09:20:09.137334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-16T09:20:09.137509Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgPreVoteResp from e3aaa5c123e150e0 at term 1"}
{"level":"info","ts":"2026-05-16T09:20:09.137644Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became candidate at term 2"}
{"level":"info","ts":"2026-05-16T09:20:09.137733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgVoteResp from e3aaa5c123e150e0 at term 2"}
{"level":"info","ts":"2026-05-16T09:20:09.137836Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became leader at term 2"}
{"level":"info","ts":"2026-05-16T09:20:09.137977Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e3aaa5c123e150e0 elected leader e3aaa5c123e150e0 at term 2"}
{"level":"info","ts":"2026-05-16T09:20:09.139068Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e3aaa5c123e150e0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.115:2379]}","request-path":"/0/members/e3aaa5c123e150e0/attributes","cluster-id":"61ec519698823541","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-16T09:20:09.139113Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-16T09:20:09.139068Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-16T09:20:09.139532Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-16T09:20:09.139742Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-16T09:20:09.139919Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-16T09:20:09.14037Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-16T09:20:09.140583Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-16T09:20:09.140669Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-16T09:20:09.142577Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-16T09:20:09.1432Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.115:2379"}
{"level":"warn","ts":"2026-05-16T09:20:14.315778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.876064ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827831847181994545 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-16T09:20:14.315907Z","caller":"traceutil/trace.go:171","msg":"trace[1663197383] transaction","detail":"{read_only:false; response_revision:244; number_of_response:1; }","duration":"277.374191ms","start":"2026-05-16T09:20:14.038522Z","end":"2026-05-16T09:20:14.315896Z","steps":["trace[1663197383] 'process raft request'  (duration: 277.33873ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:20:14.316137Z","caller":"traceutil/trace.go:171","msg":"trace[1828598389] transaction","detail":"{read_only:false; response_revision:243; number_of_response:1; }","duration":"413.222338ms","start":"2026-05-16T09:20:13.902909Z","end":"2026-05-16T09:20:14.316132Z","steps":["trace[1828598389] 'process raft request'  (duration: 124.687977ms)","trace[1828598389] 'compare'  (duration: 287.737711ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-16T09:20:14.316168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:20:13.902897Z","time spent":"413.257119ms","remote":"127.0.0.1:58368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<>"}
{"level":"warn","ts":"2026-05-16T09:20:14.605885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.962142ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827831847181994549 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterrolebindings/kubeadm:node-proxier\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/kubeadm:node-proxier\" value_size:362 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-16T09:20:14.606173Z","caller":"traceutil/trace.go:171","msg":"trace[934745262] linearizableReadLoop","detail":"{readStateIndex:255; appliedIndex:253; }","duration":"213.230897ms","start":"2026-05-16T09:20:14.392925Z","end":"2026-05-16T09:20:14.606156Z","steps":["trace[934745262] 'read index received'  (duration: 74.919976ms)","trace[934745262] 'applied index is now lower than readState.Index'  (duration: 138.307781ms)"],"step_count":2}
{"level":"info","ts":"2026-05-16T09:20:14.606367Z","caller":"traceutil/trace.go:171","msg":"trace[167259164] transaction","detail":"{read_only:false; response_revision:247; number_of_response:1; }","duration":"283.749677ms","start":"2026-05-16T09:20:14.322586Z","end":"2026-05-16T09:20:14.606336Z","steps":["trace[167259164] 'process raft request'  (duration: 283.429468ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:14.606438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.482453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-16T09:20:14.606529Z","caller":"traceutil/trace.go:171","msg":"trace[656509187] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replication-controller; range_end:; response_count:0; response_revision:247; }","duration":"213.628887ms","start":"2026-05-16T09:20:14.392876Z","end":"2026-05-16T09:20:14.606504Z","steps":["trace[656509187] 'agreement among raft nodes before linearized reading'  (duration: 213.473933ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:14.606519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.078087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-16T09:20:14.606593Z","caller":"traceutil/trace.go:171","msg":"trace[1473025483] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:247; }","duration":"130.20567ms","start":"2026-05-16T09:20:14.476366Z","end":"2026-05-16T09:20:14.606572Z","steps":["trace[1473025483] 'agreement among raft nodes before linearized reading'  (duration: 130.067286ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:20:14.606174Z","caller":"traceutil/trace.go:171","msg":"trace[1273992311] transaction","detail":"{read_only:false; response_revision:246; number_of_response:1; }","duration":"285.027801ms","start":"2026-05-16T09:20:14.321106Z","end":"2026-05-16T09:20:14.606134Z","steps":["trace[1273992311] 'process raft request'  (duration: 146.74989ms)","trace[1273992311] 'compare'  (duration: 137.801958ms)"],"step_count":2}
{"level":"info","ts":"2026-05-16T09:20:41.280643Z","caller":"traceutil/trace.go:171","msg":"trace[1381370857] linearizableReadLoop","detail":"{readStateIndex:563; appliedIndex:562; }","duration":"243.596892ms","start":"2026-05-16T09:20:41.037022Z","end":"2026-05-16T09:20:41.280619Z","steps":["trace[1381370857] 'read index received'  (duration: 243.125721ms)","trace[1381370857] 'applied index is now lower than readState.Index'  (duration: 470.231µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-16T09:20:41.28087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.816727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:18056"}
{"level":"info","ts":"2026-05-16T09:20:41.28088Z","caller":"traceutil/trace.go:171","msg":"trace[921902180] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"247.434276ms","start":"2026-05-16T09:20:41.033422Z","end":"2026-05-16T09:20:41.280857Z","steps":["trace[921902180] 'process raft request'  (duration: 246.77548ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:20:41.280946Z","caller":"traceutil/trace.go:171","msg":"trace[818397633] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:543; }","duration":"243.90815ms","start":"2026-05-16T09:20:41.037007Z","end":"2026-05-16T09:20:41.280915Z","steps":["trace[818397633] 'agreement among raft nodes before linearized reading'  (duration: 243.717796ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:20:41.28547Z","caller":"traceutil/trace.go:171","msg":"trace[960944799] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"233.949157ms","start":"2026-05-16T09:20:41.051497Z","end":"2026-05-16T09:20:41.285446Z","steps":["trace[960944799] 'process raft request'  (duration: 233.762652ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:20:45.728961Z","caller":"traceutil/trace.go:171","msg":"trace[983168482] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"141.676613ms","start":"2026-05-16T09:20:45.587243Z","end":"2026-05-16T09:20:45.72892Z","steps":["trace[983168482] 'process raft request'  (duration: 102.418633ms)","trace[983168482] 'compare'  (duration: 39.005634ms)"],"step_count":2}
{"level":"info","ts":"2026-05-16T09:20:45.729075Z","caller":"traceutil/trace.go:171","msg":"trace[653399774] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"139.043649ms","start":"2026-05-16T09:20:45.589993Z","end":"2026-05-16T09:20:45.729037Z","steps":["trace[653399774] 'process raft request'  (duration: 138.810063ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:46.252589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.073445ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827831847181995216 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:560 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-16T09:20:46.252691Z","caller":"traceutil/trace.go:171","msg":"trace[1601436074] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"475.803246ms","start":"2026-05-16T09:20:45.776869Z","end":"2026-05-16T09:20:46.252673Z","steps":["trace[1601436074] 'process raft request'  (duration: 294.376353ms)","trace[1601436074] 'compare'  (duration: 180.877459ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-16T09:20:46.252744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:20:45.776845Z","time spent":"475.873188ms","remote":"127.0.0.1:58368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:560 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-16T09:20:46.254193Z","caller":"traceutil/trace.go:171","msg":"trace[1002465963] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"112.662752ms","start":"2026-05-16T09:20:46.141506Z","end":"2026-05-16T09:20:46.254169Z","steps":["trace[1002465963] 'process raft request'  (duration: 111.494484ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:20:52.634267Z","caller":"traceutil/trace.go:171","msg":"trace[1726063809] linearizableReadLoop","detail":"{readStateIndex:694; appliedIndex:693; }","duration":"190.081014ms","start":"2026-05-16T09:20:52.444163Z","end":"2026-05-16T09:20:52.634244Z","steps":["trace[1726063809] 'read index received'  (duration: 189.880079ms)","trace[1726063809] 'applied index is now lower than readState.Index'  (duration: 200.065µs)"],"step_count":2}
{"level":"info","ts":"2026-05-16T09:20:52.634351Z","caller":"traceutil/trace.go:171","msg":"trace[164449995] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"210.305149ms","start":"2026-05-16T09:20:52.424013Z","end":"2026-05-16T09:20:52.634318Z","steps":["trace[164449995] 'process raft request'  (duration: 210.079573ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:52.634509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.259219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-16T09:20:52.634575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.569672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-16T09:20:52.634683Z","caller":"traceutil/trace.go:171","msg":"trace[651885936] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:671; }","duration":"162.701036ms","start":"2026-05-16T09:20:52.471944Z","end":"2026-05-16T09:20:52.634645Z","steps":["trace[651885936] 'agreement among raft nodes before linearized reading'  (duration: 162.517781ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:20:52.634715Z","caller":"traceutil/trace.go:171","msg":"trace[584425596] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:671; }","duration":"190.415523ms","start":"2026-05-16T09:20:52.444141Z","end":"2026-05-16T09:20:52.634557Z","steps":["trace[584425596] 'agreement among raft nodes before linearized reading'  (duration: 190.245529ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:52.634812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.855584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-16T09:20:52.634832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.854074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-16T09:20:52.634881Z","caller":"traceutil/trace.go:171","msg":"trace[418005382] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:671; }","duration":"163.907705ms","start":"2026-05-16T09:20:52.470959Z","end":"2026-05-16T09:20:52.634867Z","steps":["trace[418005382] 'agreement among raft nodes before linearized reading'  (duration: 163.821473ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:20:52.634882Z","caller":"traceutil/trace.go:171","msg":"trace[2082794486] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:671; }","duration":"163.984997ms","start":"2026-05-16T09:20:52.470878Z","end":"2026-05-16T09:20:52.634863Z","steps":["trace[2082794486] 'agreement among raft nodes before linearized reading'  (duration: 163.862364ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:52.634936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.754112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-16T09:20:52.634966Z","caller":"traceutil/trace.go:171","msg":"trace[836942962] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:671; }","duration":"145.793312ms","start":"2026-05-16T09:20:52.489164Z","end":"2026-05-16T09:20:52.634958Z","steps":["trace[836942962] 'agreement among raft nodes before linearized reading'  (duration: 145.747841ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:52.634729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.517605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-16T09:20:52.634998Z","caller":"traceutil/trace.go:171","msg":"trace[881333059] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:671; }","duration":"190.831803ms","start":"2026-05-16T09:20:52.444154Z","end":"2026-05-16T09:20:52.634986Z","steps":["trace[881333059] 'agreement among raft nodes before linearized reading'  (duration: 190.268199ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:52.635068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.738653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-16T09:20:52.635092Z","caller":"traceutil/trace.go:171","msg":"trace[1005577617] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:671; }","duration":"159.779704ms","start":"2026-05-16T09:20:52.475305Z","end":"2026-05-16T09:20:52.635085Z","steps":["trace[1005577617] 'agreement among raft nodes before linearized reading'  (duration: 159.745954ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:52.635332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.350781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-16T09:20:52.635359Z","caller":"traceutil/trace.go:171","msg":"trace[1819088483] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:671; }","duration":"145.378822ms","start":"2026-05-16T09:20:52.489974Z","end":"2026-05-16T09:20:52.635352Z","steps":["trace[1819088483] 'agreement among raft nodes before linearized reading'  (duration: 145.337261ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:52.635318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.132605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-16T09:20:52.635416Z","caller":"traceutil/trace.go:171","msg":"trace[1027336677] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:671; }","duration":"190.30307ms","start":"2026-05-16T09:20:52.445095Z","end":"2026-05-16T09:20:52.635398Z","steps":["trace[1027336677] 'agreement among raft nodes before linearized reading'  (duration: 190.126496ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:52.635341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.659269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-16T09:20:52.63684Z","caller":"traceutil/trace.go:171","msg":"trace[1911934621] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:671; }","duration":"147.640748ms","start":"2026-05-16T09:20:52.489171Z","end":"2026-05-16T09:20:52.636812Z","steps":["trace[1911934621] 'agreement among raft nodes before linearized reading'  (duration: 145.622078ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:52.634908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.508753ms","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-16T09:20:52.637055Z","caller":"traceutil/trace.go:171","msg":"trace[749374659] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:671; }","duration":"178.628024ms","start":"2026-05-16T09:20:52.458365Z","end":"2026-05-16T09:20:52.636993Z","steps":["trace[749374659] 'agreement among raft nodes before linearized reading'  (duration: 176.502742ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:53.321542Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831847181995463,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-16T09:20:53.822297Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831847181995463,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-16T09:20:54.322919Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831847181995463,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-16T09:20:54.823643Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831847181995463,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-16T09:20:55.324141Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831847181995463,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-16T09:20:55.477532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999834575s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-05-16T09:20:55.477608Z","caller":"traceutil/trace.go:171","msg":"trace[401007032] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999962008s","start":"2026-05-16T09:20:53.477631Z","end":"2026-05-16T09:20:55.477593Z","steps":["trace[401007032] 'agreement among raft nodes before linearized reading'  (duration: 1.999868126s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:55.477643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:20:53.477609Z","time spent":"2.00002691s","remote":"127.0.0.1:58116","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-16T09:20:55.824678Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831847181995463,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-16T09:20:56.324832Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831847181995463,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-16T09:20:56.825502Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831847181995463,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-16T09:20:56.998603Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"4.221738327s","expected-duration":"1s"}
{"level":"info","ts":"2026-05-16T09:20:56.999163Z","caller":"traceutil/trace.go:171","msg":"trace[1911117335] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"4.222361121s","start":"2026-05-16T09:20:52.776773Z","end":"2026-05-16T09:20:56.999134Z","steps":["trace[1911117335] 'process raft request'  (duration: 4.222186847s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:56.999336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:20:52.776763Z","time spent":"4.222479394s","remote":"127.0.0.1:58368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:650 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-05-16T09:20:57.212034Z","caller":"traceutil/trace.go:171","msg":"trace[1208657432] linearizableReadLoop","detail":"{readStateIndex:697; appliedIndex:694; }","duration":"4.391446193s","start":"2026-05-16T09:20:52.820544Z","end":"2026-05-16T09:20:57.21199Z","steps":["trace[1208657432] 'read index received'  (duration: 4.178374997s)","trace[1208657432] 'applied index is now lower than readState.Index'  (duration: 213.070036ms)"],"step_count":2}
{"level":"info","ts":"2026-05-16T09:20:57.212063Z","caller":"traceutil/trace.go:171","msg":"trace[1450598048] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"2.837944934s","start":"2026-05-16T09:20:54.37408Z","end":"2026-05-16T09:20:57.212025Z","steps":["trace[1450598048] 'process raft request'  (duration: 2.837663917s)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:20:57.212112Z","caller":"traceutil/trace.go:171","msg":"trace[1090530694] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"2.788356203s","start":"2026-05-16T09:20:54.423731Z","end":"2026-05-16T09:20:57.212087Z","steps":["trace[1090530694] 'process raft request'  (duration: 2.788201489s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:57.212244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:20:54.374056Z","time spent":"2.838094968s","remote":"127.0.0.1:58368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:563 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-05-16T09:20:57.212344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.391764002s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jwrw5\" ","response":"range_response_count:1 size:18516"}
{"level":"info","ts":"2026-05-16T09:20:57.212391Z","caller":"traceutil/trace.go:171","msg":"trace[695540422] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jwrw5; range_end:; response_count:1; response_revision:674; }","duration":"4.391869164s","start":"2026-05-16T09:20:52.82051Z","end":"2026-05-16T09:20:57.212379Z","steps":["trace[695540422] 'agreement among raft nodes before linearized reading'  (duration: 4.391647708s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:57.212442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:20:52.820495Z","time spent":"4.391937476s","remote":"127.0.0.1:58282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":18539,"request content":"key:\"/registry/pods/kube-system/cilium-jwrw5\" "}
{"level":"warn","ts":"2026-05-16T09:20:57.212503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:20:54.423708Z","time spent":"2.788454355s","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":780,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/cilium-jwrw5.18b00146567ce896\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/cilium-jwrw5.18b00146567ce896\" value_size:704 lease:5827831847181994522 >> failure:<>"}
{"level":"info","ts":"2026-05-16T09:20:57.442348Z","caller":"traceutil/trace.go:171","msg":"trace[1403236448] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"401.936921ms","start":"2026-05-16T09:20:57.040383Z","end":"2026-05-16T09:20:57.44232Z","steps":["trace[1403236448] 'process raft request'  (duration: 357.472534ms)","trace[1403236448] 'compare'  (duration: 44.198731ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-16T09:20:57.442503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:20:57.040363Z","time spent":"402.065975ms","remote":"127.0.0.1:58270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4363,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:671 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4329 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-05-16T09:20:57.479522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000819939s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-05-16T09:20:57.479606Z","caller":"traceutil/trace.go:171","msg":"trace[772726578] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000938611s","start":"2026-05-16T09:20:55.47865Z","end":"2026-05-16T09:20:57.479588Z","steps":["trace[772726578] 'agreement among raft nodes before linearized reading'  (duration: 2.000838079s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:57.479652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:20:55.478636Z","time spent":"2.001006444s","remote":"127.0.0.1:58120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-16T09:20:57.483069Z","caller":"traceutil/trace.go:171","msg":"trace[1083223972] linearizableReadLoop","detail":"{readStateIndex:699; appliedIndex:697; }","duration":"270.926581ms","start":"2026-05-16T09:20:57.212124Z","end":"2026-05-16T09:20:57.483051Z","steps":["trace[1083223972] 'read index received'  (duration: 185.744509ms)","trace[1083223972] 'applied index is now lower than readState.Index'  (duration: 85.179772ms)"],"step_count":2}
{"level":"info","ts":"2026-05-16T09:20:57.483132Z","caller":"traceutil/trace.go:171","msg":"trace[909482288] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"256.738884ms","start":"2026-05-16T09:20:57.226367Z","end":"2026-05-16T09:20:57.483106Z","steps":["trace[909482288] 'process raft request'  (duration: 256.573239ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:57.483267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.717058125s","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-16T09:20:57.483278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.201056097s","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-16T09:20:57.483326Z","caller":"traceutil/trace.go:171","msg":"trace[2042426140] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:676; }","duration":"3.717167958s","start":"2026-05-16T09:20:53.76614Z","end":"2026-05-16T09:20:57.483308Z","steps":["trace[2042426140] 'agreement among raft nodes before linearized reading'  (duration: 3.716925102s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:57.483384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:20:53.76604Z","time spent":"3.717330652s","remote":"127.0.0.1:58368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-05-16T09:20:57.48333Z","caller":"traceutil/trace.go:171","msg":"trace[420562901] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:676; }","duration":"3.201143889s","start":"2026-05-16T09:20:54.282173Z","end":"2026-05-16T09:20:57.483317Z","steps":["trace[420562901] 'agreement among raft nodes before linearized reading'  (duration: 3.201019496s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:57.483458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.896088379s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-05-16T09:20:57.48347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:20:54.282149Z","time spent":"3.201305493s","remote":"127.0.0.1:58368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-16T09:20:57.48353Z","caller":"traceutil/trace.go:171","msg":"trace[494426800] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:676; }","duration":"3.896158761s","start":"2026-05-16T09:20:53.587332Z","end":"2026-05-16T09:20:57.483491Z","steps":["trace[494426800] 'agreement among raft nodes before linearized reading'  (duration: 3.895882655s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:57.483641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.600626985s","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-16T09:20:57.483721Z","caller":"traceutil/trace.go:171","msg":"trace[463272451] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:676; }","duration":"4.600746978s","start":"2026-05-16T09:20:52.88296Z","end":"2026-05-16T09:20:57.483707Z","steps":["trace[463272451] 'agreement among raft nodes before linearized reading'  (duration: 4.600294617s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:57.483784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:20:52.882942Z","time spent":"4.60083007s","remote":"127.0.0.1:58368","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-16T09:20:57.484197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:20:53.587317Z","time spent":"3.896865508s","remote":"127.0.0.1:58368","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":"info","ts":"2026-05-16T09:20:57.617987Z","caller":"traceutil/trace.go:171","msg":"trace[1857690347] linearizableReadLoop","detail":"{readStateIndex:701; appliedIndex:700; }","duration":"134.735172ms","start":"2026-05-16T09:20:57.483229Z","end":"2026-05-16T09:20:57.617964Z","steps":["trace[1857690347] 'read index received'  (duration: 134.578208ms)","trace[1857690347] 'applied index is now lower than readState.Index'  (duration: 155.964µs)"],"step_count":2}
{"level":"info","ts":"2026-05-16T09:20:57.618023Z","caller":"traceutil/trace.go:171","msg":"trace[1114951478] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"167.872152ms","start":"2026-05-16T09:20:57.45012Z","end":"2026-05-16T09:20:57.617992Z","steps":["trace[1114951478] 'process raft request'  (duration: 167.673687ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:57.61826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.944302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/cilium-jwrw5.18b00146567ce896\" ","response":"range_response_count:1 size:795"}
{"level":"info","ts":"2026-05-16T09:20:57.618362Z","caller":"traceutil/trace.go:171","msg":"trace[1612709942] range","detail":"{range_begin:/registry/events/kube-system/cilium-jwrw5.18b00146567ce896; range_end:; response_count:1; response_revision:677; }","duration":"400.105066ms","start":"2026-05-16T09:20:57.218246Z","end":"2026-05-16T09:20:57.618351Z","steps":["trace[1612709942] 'agreement among raft nodes before linearized reading'  (duration: 399.82266ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:57.618414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:20:57.218227Z","time spent":"400.175709ms","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":818,"request content":"key:\"/registry/events/kube-system/cilium-jwrw5.18b00146567ce896\" "}
{"level":"info","ts":"2026-05-16T09:20:57.679805Z","caller":"traceutil/trace.go:171","msg":"trace[419336216] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"191.568162ms","start":"2026-05-16T09:20:57.488212Z","end":"2026-05-16T09:20:57.67978Z","steps":["trace[419336216] 'process raft request'  (duration: 191.386477ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:20:57.680243Z","caller":"traceutil/trace.go:171","msg":"trace[795824178] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"191.496479ms","start":"2026-05-16T09:20:57.48872Z","end":"2026-05-16T09:20:57.680216Z","steps":["trace[795824178] 'process raft request'  (duration: 191.010087ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:20:57.68028Z","caller":"traceutil/trace.go:171","msg":"trace[1349921741] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"190.185847ms","start":"2026-05-16T09:20:57.490073Z","end":"2026-05-16T09:20:57.680259Z","steps":["trace[1349921741] 'process raft request'  (duration: 190.054594ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:20:57.680518Z","caller":"traceutil/trace.go:171","msg":"trace[814691921] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"190.107575ms","start":"2026-05-16T09:20:57.490399Z","end":"2026-05-16T09:20:57.680507Z","steps":["trace[814691921] 'process raft request'  (duration: 189.816668ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:20:57.681091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.368744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-16T09:20:57.681149Z","caller":"traceutil/trace.go:171","msg":"trace[786490752] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:681; }","duration":"195.971689ms","start":"2026-05-16T09:20:57.485153Z","end":"2026-05-16T09:20:57.681125Z","steps":["trace[786490752] 'agreement among raft nodes before linearized reading'  (duration: 195.325573ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:21:29.977626Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831847181995930,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-16T09:21:30.477849Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831847181995930,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-16T09:21:30.978234Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831847181995930,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-16T09:21:31.477563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00041597s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-05-16T09:21:31.477654Z","caller":"traceutil/trace.go:171","msg":"trace[563790671] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000557673s","start":"2026-05-16T09:21:29.477071Z","end":"2026-05-16T09:21:31.477629Z","steps":["trace[563790671] 'agreement among raft nodes before linearized reading'  (duration: 2.000449981s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:21:31.477701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:21:29.477051Z","time spent":"2.000641335s","remote":"127.0.0.1:58116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/05/16 09:21:31 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-05-16T09:21:31.478558Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831847181995930,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-16T09:21:31.979375Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831847181995930,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-16T09:21:32.47998Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831847181995930,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-16T09:21:32.980659Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831847181995930,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-16T09:21:33.478399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000152223s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-05-16T09:21:33.478485Z","caller":"traceutil/trace.go:171","msg":"trace[1331837082] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000325077s","start":"2026-05-16T09:21:31.47814Z","end":"2026-05-16T09:21:33.478465Z","steps":["trace[1331837082] 'agreement among raft nodes before linearized reading'  (duration: 2.000207354s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:21:33.478539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:21:31.478119Z","time spent":"2.000405059s","remote":"127.0.0.1:58120","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-16T09:21:33.481732Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831847181995930,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-16T09:21:33.982488Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831847181995930,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-16T09:21:34.143271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:21:29.145413Z","time spent":"4.99785087s","remote":"127.0.0.1:58368","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
2026/05/16 09:21:34 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-05-16T09:21:34.483357Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831847181995930,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-16T09:21:34.839755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.9994745s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-05-16T09:21:34.839835Z","caller":"traceutil/trace.go:171","msg":"trace[1873394532] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"4.999621054s","start":"2026-05-16T09:21:29.840194Z","end":"2026-05-16T09:21:34.839815Z","steps":["trace[1873394532] 'agreement among raft nodes before linearized reading'  (duration: 4.99947873s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:21:34.839797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.000224678s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-05-16T09:21:34.839903Z","caller":"traceutil/trace.go:171","msg":"trace[1438668677] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"5.000372082s","start":"2026-05-16T09:21:29.839507Z","end":"2026-05-16T09:21:34.839879Z","steps":["trace[1438668677] 'agreement among raft nodes before linearized reading'  (duration: 5.000243829s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:21:34.839924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:21:29.840175Z","time spent":"4.999736257s","remote":"127.0.0.1:58368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-05-16T09:21:34.839964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:21:29.839498Z","time spent":"5.000452884s","remote":"127.0.0.1:58368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
2026/05/16 09:21:34 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
2026/05/16 09:21:34 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-05-16T09:21:34.984137Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831847181995930,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-16T09:21:35.484895Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831847181995930,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-16T09:21:35.487312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000616294s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-05-16T09:21:35.48737Z","caller":"traceutil/trace.go:171","msg":"trace[423107456] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000717117s","start":"2026-05-16T09:21:33.486636Z","end":"2026-05-16T09:21:35.487353Z","steps":["trace[423107456] 'agreement among raft nodes before linearized reading'  (duration: 2.000640125s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:21:35.487419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:21:33.48662Z","time spent":"2.000790108s","remote":"127.0.0.1:58116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/05/16 09:21:35 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-05-16T09:21:35.986003Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831847181995930,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-16T09:21:36.100456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:21:31.101529Z","time spent":"4.998918747s","remote":"127.0.0.1:58368","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-05-16T09:21:36.477954Z","caller":"etcdserver/v3_server.go:909","msg":"timed out waiting for read index response (local node might have slow network)","timeout":"7s"}
{"level":"warn","ts":"2026-05-16T09:21:36.978873Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831847181995934,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-16T09:21:37.408907Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"8.263378742s","expected-duration":"1s"}
{"level":"warn","ts":"2026-05-16T09:21:37.487891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000239305s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-05-16T09:21:37.488037Z","caller":"traceutil/trace.go:171","msg":"trace[1439040663] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000479551s","start":"2026-05-16T09:21:35.487533Z","end":"2026-05-16T09:21:37.488013Z","steps":["trace[1439040663] 'agreement among raft nodes before linearized reading'  (duration: 2.000305617s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:21:37.488096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:21:35.487517Z","time spent":"2.000565553s","remote":"127.0.0.1:58120","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-16T09:21:37.492381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.063444345s","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-16T09:21:37.492493Z","caller":"traceutil/trace.go:171","msg":"trace[856644925] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:911; }","duration":"1.063562517s","start":"2026-05-16T09:21:36.428917Z","end":"2026-05-16T09:21:37.492479Z","steps":["trace[856644925] 'range keys from in-memory index tree'  (duration: 1.063429004s)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:21:37.63205Z","caller":"traceutil/trace.go:171","msg":"trace[113136281] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"5.219560208s","start":"2026-05-16T09:21:32.412464Z","end":"2026-05-16T09:21:37.632024Z","steps":["trace[113136281] 'process raft request'  (duration: 5.219408154s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:21:37.632373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:21:32.412433Z","time spent":"5.219835144s","remote":"127.0.0.1:58368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:880 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-05-16T09:21:37.696998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.68837912s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-05-16T09:21:37.697022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.231114192s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-16T09:21:37.697084Z","caller":"traceutil/trace.go:171","msg":"trace[261901333] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:915; }","duration":"2.688506862s","start":"2026-05-16T09:21:35.00856Z","end":"2026-05-16T09:21:37.697067Z","steps":["trace[261901333] 'agreement among raft nodes before linearized reading'  (duration: 2.688351899s)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:21:37.6971Z","caller":"traceutil/trace.go:171","msg":"trace[715596410] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:915; }","duration":"1.231252696s","start":"2026-05-16T09:21:36.465833Z","end":"2026-05-16T09:21:37.697085Z","steps":["trace[715596410] 'agreement among raft nodes before linearized reading'  (duration: 1.231102862s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:21:37.697148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:21:36.465803Z","time spent":"1.231329297s","remote":"127.0.0.1:58422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":16,"response size":30,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "}
{"level":"warn","ts":"2026-05-16T09:21:37.697164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:21:35.008551Z","time spent":"2.688599075s","remote":"127.0.0.1:58224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":5,"response size":30,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "}
{"level":"warn","ts":"2026-05-16T09:21:37.69744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.595585238s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:549"}
{"level":"info","ts":"2026-05-16T09:21:37.697488Z","caller":"traceutil/trace.go:171","msg":"trace[375657328] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:915; }","duration":"1.5956705s","start":"2026-05-16T09:21:36.101803Z","end":"2026-05-16T09:21:37.697474Z","steps":["trace[375657328] 'agreement among raft nodes before linearized reading'  (duration: 1.595588518s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:21:37.697516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.515294609s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-16T09:21:37.697606Z","caller":"traceutil/trace.go:171","msg":"trace[1805703688] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:915; }","duration":"4.515448303s","start":"2026-05-16T09:21:33.182139Z","end":"2026-05-16T09:21:37.697587Z","steps":["trace[1805703688] 'agreement among raft nodes before linearized reading'  (duration: 4.515261508s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:21:37.697669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:21:33.182117Z","time spent":"4.515540806s","remote":"127.0.0.1:58378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":3,"response size":30,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "}
{"level":"warn","ts":"2026-05-16T09:21:37.697663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.665597793s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-16T09:21:37.697732Z","caller":"traceutil/trace.go:171","msg":"trace[1900452660] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:915; }","duration":"2.665703996s","start":"2026-05-16T09:21:35.032017Z","end":"2026-05-16T09:21:37.697721Z","steps":["trace[1900452660] 'agreement among raft nodes before linearized reading'  (duration: 2.665593303s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:21:37.697716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.930906789s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-16T09:21:37.697841Z","caller":"traceutil/trace.go:171","msg":"trace[1300070045] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:915; }","duration":"5.931151985s","start":"2026-05-16T09:21:31.766667Z","end":"2026-05-16T09:21:37.697819Z","steps":["trace[1300070045] 'agreement among raft nodes before linearized reading'  (duration: 5.930854118s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:21:37.697908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:21:31.766639Z","time spent":"5.931257947s","remote":"127.0.0.1:58258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "}
{"level":"warn","ts":"2026-05-16T09:21:37.697939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.861191555s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-16T09:21:37.697979Z","caller":"traceutil/trace.go:171","msg":"trace[1631814157] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:915; }","duration":"7.861288257s","start":"2026-05-16T09:21:29.836679Z","end":"2026-05-16T09:21:37.697967Z","steps":["trace[1631814157] 'agreement among raft nodes before linearized reading'  (duration: 7.861123523s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:21:37.698039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:21:29.836603Z","time spent":"7.861426501s","remote":"127.0.0.1:58368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-05-16T09:21:37.698034Z","caller":"traceutil/trace.go:171","msg":"trace[1238001136] linearizableReadLoop","detail":"{readStateIndex:946; appliedIndex:943; }","duration":"1.218773741s","start":"2026-05-16T09:21:36.478105Z","end":"2026-05-16T09:21:37.696879Z","steps":["trace[1238001136] 'read index received'  (duration: 931.075791ms)","trace[1238001136] 'applied index is now lower than readState.Index'  (duration: 287.69619ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-16T09:21:37.69805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:21:35.031993Z","time spent":"2.666031763s","remote":"127.0.0.1:58218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":14,"response size":30,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "}
{"level":"warn","ts":"2026-05-16T09:21:37.698284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.863644054s","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-16T09:21:37.698343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.695030172s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-16T09:21:37.698388Z","caller":"traceutil/trace.go:171","msg":"trace[72877562] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:915; }","duration":"2.695116954s","start":"2026-05-16T09:21:35.003257Z","end":"2026-05-16T09:21:37.698374Z","steps":["trace[72877562] 'agreement among raft nodes before linearized reading'  (duration: 2.695044442s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:21:37.69843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:21:35.003236Z","time spent":"2.695185666s","remote":"127.0.0.1:58408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "}
{"level":"warn","ts":"2026-05-16T09:21:37.698427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.385149839s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-05-16T09:21:37.697553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:21:36.101784Z","time spent":"1.595757362s","remote":"127.0.0.1:58368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":572,"request content":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" "}
{"level":"info","ts":"2026-05-16T09:21:37.698477Z","caller":"traceutil/trace.go:171","msg":"trace[455793762] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:915; }","duration":"4.385241111s","start":"2026-05-16T09:21:33.313223Z","end":"2026-05-16T09:21:37.698464Z","steps":["trace[455793762] 'agreement among raft nodes before linearized reading'  (duration: 4.385164679s)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:21:37.698344Z","caller":"traceutil/trace.go:171","msg":"trace[59315045] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:915; }","duration":"7.863776738s","start":"2026-05-16T09:21:29.834551Z","end":"2026-05-16T09:21:37.698328Z","steps":["trace[59315045] 'agreement among raft nodes before linearized reading'  (duration: 7.863623794s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:21:37.69853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"857.166804ms","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-16T09:21:37.698562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:21:33.313204Z","time spent":"4.385313813s","remote":"127.0.0.1:58472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":30,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "}
{"level":"warn","ts":"2026-05-16T09:21:37.698557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.610132851s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.115\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-16T09:21:37.698584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:21:29.834523Z","time spent":"7.864051525s","remote":"127.0.0.1:58368","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-16T09:21:37.698727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.902844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-16T09:21:37.69872Z","caller":"traceutil/trace.go:171","msg":"trace[1689580832] range","detail":"{range_begin:/registry/masterleases/199.204.45.115; range_end:; response_count:0; response_revision:915; }","duration":"5.611075365s","start":"2026-05-16T09:21:32.087624Z","end":"2026-05-16T09:21:37.698699Z","steps":["trace[1689580832] 'agreement among raft nodes before linearized reading'  (duration: 5.609993909s)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:21:37.698642Z","caller":"traceutil/trace.go:171","msg":"trace[563604195] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:915; }","duration":"857.261977ms","start":"2026-05-16T09:21:36.841324Z","end":"2026-05-16T09:21:37.698586Z","steps":["trace[563604195] 'agreement among raft nodes before linearized reading'  (duration: 857.025431ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:21:37.698865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"856.175469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-05-16T09:21:37.698897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.216772505s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18b001470ccd85c3\" ","response":"range_response_count:1 size:774"}
{"level":"info","ts":"2026-05-16T09:21:37.698945Z","caller":"traceutil/trace.go:171","msg":"trace[1412027095] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18b001470ccd85c3; range_end:; response_count:1; response_revision:915; }","duration":"4.216857396s","start":"2026-05-16T09:21:33.482076Z","end":"2026-05-16T09:21:37.698933Z","steps":["trace[1412027095] 'agreement among raft nodes before linearized reading'  (duration: 4.216690252s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:21:37.698977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:21:33.482057Z","time spent":"4.216913288s","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":797,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18b001470ccd85c3\" "}
{"level":"info","ts":"2026-05-16T09:21:37.698811Z","caller":"traceutil/trace.go:171","msg":"trace[1928005313] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:915; }","duration":"199.977666ms","start":"2026-05-16T09:21:37.498815Z","end":"2026-05-16T09:21:37.698792Z","steps":["trace[1928005313] 'agreement among raft nodes before linearized reading'  (duration: 199.847123ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:21:37.698923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.554235098s","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-16T09:21:37.699047Z","caller":"traceutil/trace.go:171","msg":"trace[800587241] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:915; }","duration":"856.246551ms","start":"2026-05-16T09:21:36.842637Z","end":"2026-05-16T09:21:37.698883Z","steps":["trace[800587241] 'agreement among raft nodes before linearized reading'  (duration: 856.110028ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:21:37.699263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:21:36.842607Z","time spent":"856.644831ms","remote":"127.0.0.1:58368","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-16T09:21:37.699008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:21:36.841305Z","time spent":"857.563464ms","remote":"127.0.0.1:58368","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-16T09:21:37.700163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:21:32.087591Z","time spent":"5.61255212s","remote":"127.0.0.1:58160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/199.204.45.115\" "}
{"level":"info","ts":"2026-05-16T09:21:37.700258Z","caller":"traceutil/trace.go:171","msg":"trace[918394636] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:915; }","duration":"1.554501013s","start":"2026-05-16T09:21:36.144632Z","end":"2026-05-16T09:21:37.699133Z","steps":["trace[918394636] 'agreement among raft nodes before linearized reading'  (duration: 1.552554446s)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:21:37.700326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:21:36.144612Z","time spent":"1.555696953s","remote":"127.0.0.1:58368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-16T09:21:37.811099Z","caller":"traceutil/trace.go:171","msg":"trace[50290382] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"107.717872ms","start":"2026-05-16T09:21:37.703355Z","end":"2026-05-16T09:21:37.811073Z","steps":["trace[50290382] 'process raft request'  (duration: 107.419204ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:21:37.811138Z","caller":"traceutil/trace.go:171","msg":"trace[1550800509] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"106.41964ms","start":"2026-05-16T09:21:37.704683Z","end":"2026-05-16T09:21:37.811103Z","steps":["trace[1550800509] 'process raft request'  (duration: 106.246646ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:21:37.811175Z","caller":"traceutil/trace.go:171","msg":"trace[1487233193] linearizableReadLoop","detail":"{readStateIndex:949; appliedIndex:947; }","duration":"107.919737ms","start":"2026-05-16T09:21:37.703209Z","end":"2026-05-16T09:21:37.811129Z","steps":["trace[1487233193] 'read index received'  (duration: 25.604836ms)","trace[1487233193] 'applied index is now lower than readState.Index'  (duration: 82.314031ms)"],"step_count":2}
{"level":"info","ts":"2026-05-16T09:21:37.811364Z","caller":"traceutil/trace.go:171","msg":"trace[705267527] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"106.01617ms","start":"2026-05-16T09:21:37.705333Z","end":"2026-05-16T09:21:37.811349Z","steps":["trace[705267527] 'process raft request'  (duration: 105.698143ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:21:37.811392Z","caller":"traceutil/trace.go:171","msg":"trace[274503690] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"104.599726ms","start":"2026-05-16T09:21:37.706781Z","end":"2026-05-16T09:21:37.81138Z","steps":["trace[274503690] 'process raft request'  (duration: 104.311359ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:21:37.811496Z","caller":"traceutil/trace.go:171","msg":"trace[1809444433] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"106.567164ms","start":"2026-05-16T09:21:37.704915Z","end":"2026-05-16T09:21:37.811482Z","steps":["trace[1809444433] 'process raft request'  (duration: 106.081553ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:21:37.81179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.550093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:549"}
{"level":"info","ts":"2026-05-16T09:21:37.811893Z","caller":"traceutil/trace.go:171","msg":"trace[1966010521] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:921; }","duration":"108.650735ms","start":"2026-05-16T09:21:37.703189Z","end":"2026-05-16T09:21:37.81184Z","steps":["trace[1966010521] 'agreement among raft nodes before linearized reading'  (duration: 108.296446ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:21:38.045261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.49949ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827831847181995950 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.18b001470ccd85c3\" mod_revision:916 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.18b001470ccd85c3\" value_size:672 lease:5827831847181995680 >> failure:<request_range:<key:\"/registry/events/kube-system/kube-apiserver-instance.18b001470ccd85c3\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-16T09:21:38.045381Z","caller":"traceutil/trace.go:171","msg":"trace[1733157916] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"149.540144ms","start":"2026-05-16T09:21:37.895831Z","end":"2026-05-16T09:21:38.045371Z","steps":["trace[1733157916] 'process raft request'  (duration: 149.505553ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:21:38.045622Z","caller":"traceutil/trace.go:171","msg":"trace[628097111] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"230.167004ms","start":"2026-05-16T09:21:37.81542Z","end":"2026-05-16T09:21:38.045587Z","steps":["trace[628097111] 'process raft request'  (duration: 99.277455ms)","trace[628097111] 'compare'  (duration: 130.426168ms)"],"step_count":2}
{"level":"info","ts":"2026-05-16T09:21:38.045454Z","caller":"traceutil/trace.go:171","msg":"trace[969213815] linearizableReadLoop","detail":"{readStateIndex:956; appliedIndex:955; }","duration":"184.500329ms","start":"2026-05-16T09:21:37.860917Z","end":"2026-05-16T09:21:38.045418Z","steps":["trace[969213815] 'read index received'  (duration: 53.785214ms)","trace[969213815] 'applied index is now lower than readState.Index'  (duration: 130.711815ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-16T09:21:38.045795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.857167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-05-16T09:21:38.046233Z","caller":"traceutil/trace.go:171","msg":"trace[1397926359] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:924; }","duration":"185.307698ms","start":"2026-05-16T09:21:37.860907Z","end":"2026-05-16T09:21:38.046215Z","steps":["trace[1397926359] 'agreement among raft nodes before linearized reading'  (duration: 184.799096ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:22:44.453006Z","caller":"traceutil/trace.go:171","msg":"trace[470730396] linearizableReadLoop","detail":"{readStateIndex:1264; appliedIndex:1263; }","duration":"154.700042ms","start":"2026-05-16T09:22:44.298281Z","end":"2026-05-16T09:22:44.452981Z","steps":["trace[470730396] 'read index received'  (duration: 101.298633ms)","trace[470730396] 'applied index is now lower than readState.Index'  (duration: 53.399759ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-16T09:22:44.453192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.882996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-16T09:22:44.453275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.801944ms","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-16T09:22:44.453286Z","caller":"traceutil/trace.go:171","msg":"trace[608421332] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1216; }","duration":"155.01975ms","start":"2026-05-16T09:22:44.298247Z","end":"2026-05-16T09:22:44.453267Z","steps":["trace[608421332] 'agreement among raft nodes before linearized reading'  (duration: 154.874086ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:22:44.453144Z","caller":"traceutil/trace.go:171","msg":"trace[367834670] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"210.041747ms","start":"2026-05-16T09:22:44.243081Z","end":"2026-05-16T09:22:44.453123Z","steps":["trace[367834670] 'process raft request'  (duration: 156.565387ms)","trace[367834670] 'compare'  (duration: 52.864366ms)"],"step_count":2}
{"level":"info","ts":"2026-05-16T09:22:44.453318Z","caller":"traceutil/trace.go:171","msg":"trace[2039218840] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1216; }","duration":"120.884057ms","start":"2026-05-16T09:22:44.332424Z","end":"2026-05-16T09:22:44.453308Z","steps":["trace[2039218840] 'agreement among raft nodes before linearized reading'  (duration: 120.712512ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:22:44.453544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.128569ms","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-16T09:22:44.453703Z","caller":"traceutil/trace.go:171","msg":"trace[2141222578] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1216; }","duration":"118.311965ms","start":"2026-05-16T09:22:44.335368Z","end":"2026-05-16T09:22:44.45368Z","steps":["trace[2141222578] 'agreement among raft nodes before linearized reading'  (duration: 117.869804ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:22:44.63765Z","caller":"traceutil/trace.go:171","msg":"trace[575963872] linearizableReadLoop","detail":"{readStateIndex:1267; appliedIndex:1264; }","duration":"160.375108ms","start":"2026-05-16T09:22:44.477251Z","end":"2026-05-16T09:22:44.637626Z","steps":["trace[575963872] 'read index received'  (duration: 77.200882ms)","trace[575963872] 'applied index is now lower than readState.Index'  (duration: 83.173246ms)"],"step_count":2}
{"level":"info","ts":"2026-05-16T09:22:44.637674Z","caller":"traceutil/trace.go:171","msg":"trace[769289122] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"179.931721ms","start":"2026-05-16T09:22:44.457714Z","end":"2026-05-16T09:22:44.637645Z","steps":["trace[769289122] 'process raft request'  (duration: 96.744584ms)","trace[769289122] 'compare'  (duration: 82.943351ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-16T09:22:44.637789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.515302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-16T09:22:44.637824Z","caller":"traceutil/trace.go:171","msg":"trace[1949098796] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1219; }","duration":"160.599943ms","start":"2026-05-16T09:22:44.477212Z","end":"2026-05-16T09:22:44.637812Z","steps":["trace[1949098796] 'agreement among raft nodes before linearized reading'  (duration: 160.504631ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:22:44.638161Z","caller":"traceutil/trace.go:171","msg":"trace[1569278516] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"179.50234ms","start":"2026-05-16T09:22:44.458645Z","end":"2026-05-16T09:22:44.638148Z","steps":["trace[1569278516] 'process raft request'  (duration: 178.890086ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:22:44.638263Z","caller":"traceutil/trace.go:171","msg":"trace[645517307] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"178.136487ms","start":"2026-05-16T09:22:44.460112Z","end":"2026-05-16T09:22:44.638248Z","steps":["trace[645517307] 'process raft request'  (duration: 177.466171ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:22:44.76836Z","caller":"traceutil/trace.go:171","msg":"trace[1396293929] linearizableReadLoop","detail":"{readStateIndex:1268; appliedIndex:1267; }","duration":"125.675192ms","start":"2026-05-16T09:22:44.642669Z","end":"2026-05-16T09:22:44.768344Z","steps":["trace[1396293929] 'read index received'  (duration: 125.640011ms)","trace[1396293929] 'applied index is now lower than readState.Index'  (duration: 34.251µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-16T09:22:44.768508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.823195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"}
{"level":"info","ts":"2026-05-16T09:22:44.768535Z","caller":"traceutil/trace.go:171","msg":"trace[1644266497] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1220; }","duration":"125.897227ms","start":"2026-05-16T09:22:44.642629Z","end":"2026-05-16T09:22:44.768527Z","steps":["trace[1644266497] 'agreement among raft nodes before linearized reading'  (duration: 125.775654ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:22:44.768628Z","caller":"traceutil/trace.go:171","msg":"trace[1609872127] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"198.95778ms","start":"2026-05-16T09:22:44.569643Z","end":"2026-05-16T09:22:44.768601Z","steps":["trace[1609872127] 'process raft request'  (duration: 198.625542ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:22:44.773476Z","caller":"traceutil/trace.go:171","msg":"trace[739788677] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"129.32229ms","start":"2026-05-16T09:22:44.644144Z","end":"2026-05-16T09:22:44.773467Z","steps":["trace[739788677] 'process raft request'  (duration: 129.269418ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:22:50.397674Z","caller":"traceutil/trace.go:171","msg":"trace[399375010] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"102.735088ms","start":"2026-05-16T09:22:50.294903Z","end":"2026-05-16T09:22:50.397638Z","steps":["trace[399375010] 'process raft request'  (duration: 93.826823ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:22:57.715542Z","caller":"traceutil/trace.go:171","msg":"trace[1557779787] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"145.85124ms","start":"2026-05-16T09:22:57.569661Z","end":"2026-05-16T09:22:57.715512Z","steps":["trace[1557779787] 'process raft request'  (duration: 145.591163ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:23:50.048064Z","caller":"traceutil/trace.go:171","msg":"trace[873358186] transaction","detail":"{read_only:false; response_revision:1546; number_of_response:1; }","duration":"115.421553ms","start":"2026-05-16T09:23:49.932612Z","end":"2026-05-16T09:23:50.048034Z","steps":["trace[873358186] 'process raft request'  (duration: 115.218628ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:23:50.43149Z","caller":"traceutil/trace.go:171","msg":"trace[119904409] transaction","detail":"{read_only:false; response_revision:1548; number_of_response:1; }","duration":"308.905209ms","start":"2026-05-16T09:23:50.122544Z","end":"2026-05-16T09:23:50.431449Z","steps":["trace[119904409] 'process raft request'  (duration: 269.39743ms)","trace[119904409] 'compare'  (duration: 38.966486ms)"],"step_count":2}
{"level":"info","ts":"2026-05-16T09:23:50.431301Z","caller":"traceutil/trace.go:171","msg":"trace[1160379160] linearizableReadLoop","detail":"{readStateIndex:1609; appliedIndex:1608; }","duration":"187.02854ms","start":"2026-05-16T09:23:50.244244Z","end":"2026-05-16T09:23:50.431273Z","steps":["trace[1160379160] 'read index received'  (duration: 147.687045ms)","trace[1160379160] 'applied index is now lower than readState.Index'  (duration: 39.340045ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-16T09:23:50.43165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.390289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-16T09:23:50.431676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:23:50.122516Z","time spent":"309.076712ms","remote":"127.0.0.1:58368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:1502 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-05-16T09:23:50.431722Z","caller":"traceutil/trace.go:171","msg":"trace[273118155] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1548; }","duration":"187.520382ms","start":"2026-05-16T09:23:50.244181Z","end":"2026-05-16T09:23:50.431702Z","steps":["trace[273118155] 'agreement among raft nodes before linearized reading'  (duration: 187.359957ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:23:50.67606Z","caller":"traceutil/trace.go:171","msg":"trace[80883006] transaction","detail":"{read_only:false; response_revision:1551; number_of_response:1; }","duration":"164.413292ms","start":"2026-05-16T09:23:50.51162Z","end":"2026-05-16T09:23:50.676033Z","steps":["trace[80883006] 'process raft request'  (duration: 164.223127ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:23:50.800036Z","caller":"traceutil/trace.go:171","msg":"trace[952863932] transaction","detail":"{read_only:false; response_revision:1552; number_of_response:1; }","duration":"104.844295ms","start":"2026-05-16T09:23:50.695167Z","end":"2026-05-16T09:23:50.800011Z","steps":["trace[952863932] 'process raft request'  (duration: 58.745977ms)","trace[952863932] 'compare'  (duration: 45.716939ms)"],"step_count":2}
{"level":"info","ts":"2026-05-16T09:23:52.247841Z","caller":"traceutil/trace.go:171","msg":"trace[430909974] linearizableReadLoop","detail":"{readStateIndex:1619; appliedIndex:1618; }","duration":"102.355455ms","start":"2026-05-16T09:23:52.14546Z","end":"2026-05-16T09:23:52.247815Z","steps":["trace[430909974] 'read index received'  (duration: 45.130165ms)","trace[430909974] 'applied index is now lower than readState.Index'  (duration: 57.22394ms)"],"step_count":2}
{"level":"info","ts":"2026-05-16T09:23:52.247874Z","caller":"traceutil/trace.go:171","msg":"trace[148374375] transaction","detail":"{read_only:false; response_revision:1557; number_of_response:1; }","duration":"121.733225ms","start":"2026-05-16T09:23:52.126093Z","end":"2026-05-16T09:23:52.247827Z","steps":["trace[148374375] 'process raft request'  (duration: 64.563767ms)","trace[148374375] 'compare'  (duration: 56.955673ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-16T09:23:52.248123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.640662ms","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:532"}
{"level":"info","ts":"2026-05-16T09:23:52.248169Z","caller":"traceutil/trace.go:171","msg":"trace[1719257475] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1557; }","duration":"102.855397ms","start":"2026-05-16T09:23:52.145299Z","end":"2026-05-16T09:23:52.248155Z","steps":["trace[1719257475] 'agreement among raft nodes before linearized reading'  (duration: 102.648042ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:23:53.15044Z","caller":"traceutil/trace.go:171","msg":"trace[257116267] transaction","detail":"{read_only:false; response_revision:1563; number_of_response:1; }","duration":"123.523418ms","start":"2026-05-16T09:23:53.026899Z","end":"2026-05-16T09:23:53.150422Z","steps":["trace[257116267] 'process raft request'  (duration: 123.396225ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:23:54.78896Z","caller":"traceutil/trace.go:171","msg":"trace[657327624] transaction","detail":"{read_only:false; response_revision:1568; number_of_response:1; }","duration":"213.841311ms","start":"2026-05-16T09:23:54.575088Z","end":"2026-05-16T09:23:54.78893Z","steps":["trace[657327624] 'process raft request'  (duration: 213.582735ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:23:57.096687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.178928ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827831847181997505 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1570 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-16T09:23:57.097216Z","caller":"traceutil/trace.go:171","msg":"trace[970986962] transaction","detail":"{read_only:false; response_revision:1579; number_of_response:1; }","duration":"153.23436ms","start":"2026-05-16T09:23:56.943955Z","end":"2026-05-16T09:23:57.09719Z","steps":["trace[970986962] 'process raft request'  (duration: 153.110437ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:23:57.097241Z","caller":"traceutil/trace.go:171","msg":"trace[1527470479] transaction","detail":"{read_only:false; response_revision:1578; number_of_response:1; }","duration":"155.013823ms","start":"2026-05-16T09:23:56.942191Z","end":"2026-05-16T09:23:57.097205Z","steps":["trace[1527470479] 'process raft request'  (duration: 34.22357ms)","trace[1527470479] 'compare'  (duration: 120.060475ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-16T09:23:59.207268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.581408ms","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-16T09:23:59.207396Z","caller":"traceutil/trace.go:171","msg":"trace[983117515] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1586; }","duration":"106.771782ms","start":"2026-05-16T09:23:59.100595Z","end":"2026-05-16T09:23:59.207367Z","steps":["trace[983117515] 'range keys from in-memory index tree'  (duration: 106.380433ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:23:59.435908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.738959ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827831847181997527 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1580 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-16T09:23:59.436101Z","caller":"traceutil/trace.go:171","msg":"trace[1037212981] transaction","detail":"{read_only:false; response_revision:1588; number_of_response:1; }","duration":"224.158821ms","start":"2026-05-16T09:23:59.211897Z","end":"2026-05-16T09:23:59.436055Z","steps":["trace[1037212981] 'process raft request'  (duration: 120.144887ms)","trace[1037212981] 'compare'  (duration: 103.546243ms)"],"step_count":2}
{"level":"info","ts":"2026-05-16T09:23:59.436066Z","caller":"traceutil/trace.go:171","msg":"trace[1360438707] linearizableReadLoop","detail":"{readStateIndex:1651; appliedIndex:1650; }","duration":"153.059546ms","start":"2026-05-16T09:23:59.282981Z","end":"2026-05-16T09:23:59.436041Z","steps":["trace[1360438707] 'read index received'  (duration: 48.956749ms)","trace[1360438707] 'applied index is now lower than readState.Index'  (duration: 104.101227ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-16T09:23:59.436339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.336792ms","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-16T09:23:59.436417Z","caller":"traceutil/trace.go:171","msg":"trace[1219505283] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1588; }","duration":"153.463216ms","start":"2026-05-16T09:23:59.282934Z","end":"2026-05-16T09:23:59.436397Z","steps":["trace[1219505283] 'agreement among raft nodes before linearized reading'  (duration: 153.188059ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:23:59.436502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.087455ms","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-16T09:23:59.436572Z","caller":"traceutil/trace.go:171","msg":"trace[1965385105] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1588; }","duration":"113.215388ms","start":"2026-05-16T09:23:59.323339Z","end":"2026-05-16T09:23:59.436554Z","steps":["trace[1965385105] 'agreement among raft nodes before linearized reading'  (duration: 112.915891ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:23:59.951398Z","caller":"traceutil/trace.go:171","msg":"trace[1661759675] linearizableReadLoop","detail":"{readStateIndex:1654; appliedIndex:1653; }","duration":"103.250856ms","start":"2026-05-16T09:23:59.848121Z","end":"2026-05-16T09:23:59.951372Z","steps":["trace[1661759675] 'read index received'  (duration: 103.116343ms)","trace[1661759675] 'applied index is now lower than readState.Index'  (duration: 133.033µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-16T09:23:59.951605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.446261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-16T09:23:59.951678Z","caller":"traceutil/trace.go:171","msg":"trace[1530424949] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1591; }","duration":"103.564053ms","start":"2026-05-16T09:23:59.848097Z","end":"2026-05-16T09:23:59.951661Z","steps":["trace[1530424949] 'agreement among raft nodes before linearized reading'  (duration: 103.42684ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:23:59.951662Z","caller":"traceutil/trace.go:171","msg":"trace[505011902] transaction","detail":"{read_only:false; response_revision:1591; number_of_response:1; }","duration":"106.222049ms","start":"2026-05-16T09:23:59.845277Z","end":"2026-05-16T09:23:59.951499Z","steps":["trace[505011902] 'process raft request'  (duration: 105.954182ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:24:00.597224Z","caller":"traceutil/trace.go:171","msg":"trace[217289270] linearizableReadLoop","detail":"{readStateIndex:1656; appliedIndex:1655; }","duration":"117.896362ms","start":"2026-05-16T09:24:00.479307Z","end":"2026-05-16T09:24:00.597203Z","steps":["trace[217289270] 'read index received'  (duration: 117.693797ms)","trace[217289270] 'applied index is now lower than readState.Index'  (duration: 201.805µs)"],"step_count":2}
{"level":"info","ts":"2026-05-16T09:24:00.597282Z","caller":"traceutil/trace.go:171","msg":"trace[1465034886] transaction","detail":"{read_only:false; response_revision:1593; number_of_response:1; }","duration":"156.422287ms","start":"2026-05-16T09:24:00.440823Z","end":"2026-05-16T09:24:00.597245Z","steps":["trace[1465034886] 'process raft request'  (duration: 156.249073ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:24:00.597369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.046495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-16T09:24:00.597523Z","caller":"traceutil/trace.go:171","msg":"trace[1867180019] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1593; }","duration":"118.22444ms","start":"2026-05-16T09:24:00.479252Z","end":"2026-05-16T09:24:00.597477Z","steps":["trace[1867180019] 'agreement among raft nodes before linearized reading'  (duration: 118.027855ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:24:00.597562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.03188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-16T09:24:00.5976Z","caller":"traceutil/trace.go:171","msg":"trace[1119108029] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1593; }","duration":"117.108722ms","start":"2026-05-16T09:24:00.48048Z","end":"2026-05-16T09:24:00.597589Z","steps":["trace[1119108029] 'agreement among raft nodes before linearized reading'  (duration: 116.917538ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:24:00.597947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.350674ms","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:532"}
{"level":"info","ts":"2026-05-16T09:24:00.597974Z","caller":"traceutil/trace.go:171","msg":"trace[1710662872] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1593; }","duration":"118.416775ms","start":"2026-05-16T09:24:00.479551Z","end":"2026-05-16T09:24:00.597967Z","steps":["trace[1710662872] 'agreement among raft nodes before linearized reading'  (duration: 117.80953ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:24:00.985137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.92036ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827831847181997542 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1585 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-16T09:24:00.985254Z","caller":"traceutil/trace.go:171","msg":"trace[1814512015] transaction","detail":"{read_only:false; response_revision:1595; number_of_response:1; }","duration":"310.856356ms","start":"2026-05-16T09:24:00.674376Z","end":"2026-05-16T09:24:00.985232Z","steps":["trace[1814512015] 'process raft request'  (duration: 57.69188ms)","trace[1814512015] 'compare'  (duration: 252.791567ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-16T09:24:00.985386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T09:24:00.674347Z","time spent":"311.00254ms","remote":"127.0.0.1:58368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1585 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-16T09:24:01.022051Z","caller":"traceutil/trace.go:171","msg":"trace[802207083] linearizableReadLoop","detail":"{readStateIndex:1659; appliedIndex:1658; }","duration":"188.317561ms","start":"2026-05-16T09:24:00.833708Z","end":"2026-05-16T09:24:01.022026Z","steps":["trace[802207083] 'read index received'  (duration: 187.915532ms)","trace[802207083] 'applied index is now lower than readState.Index'  (duration: 400.529µs)"],"step_count":2}
{"level":"info","ts":"2026-05-16T09:24:01.022084Z","caller":"traceutil/trace.go:171","msg":"trace[87899551] transaction","detail":"{read_only:false; response_revision:1596; number_of_response:1; }","duration":"271.361487ms","start":"2026-05-16T09:24:00.750699Z","end":"2026-05-16T09:24:01.02206Z","steps":["trace[87899551] 'process raft request'  (duration: 271.015609ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-16T09:24:01.022233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.467815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-16T09:24:01.022303Z","caller":"traceutil/trace.go:171","msg":"trace[96415962] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1596; }","duration":"188.608259ms","start":"2026-05-16T09:24:00.833657Z","end":"2026-05-16T09:24:01.022265Z","steps":["trace[96415962] 'agreement among raft nodes before linearized reading'  (duration: 188.460225ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:24:01.225392Z","caller":"traceutil/trace.go:171","msg":"trace[2049132086] transaction","detail":"{read_only:false; response_revision:1597; number_of_response:1; }","duration":"160.550049ms","start":"2026-05-16T09:24:01.064811Z","end":"2026-05-16T09:24:01.225361Z","steps":["trace[2049132086] 'process raft request'  (duration: 80.500485ms)","trace[2049132086] 'compare'  (duration: 78.992567ms)"],"step_count":2}
{"level":"info","ts":"2026-05-16T09:24:01.679104Z","caller":"traceutil/trace.go:171","msg":"trace[659717468] transaction","detail":"{read_only:false; response_revision:1601; number_of_response:1; }","duration":"103.764909ms","start":"2026-05-16T09:24:01.575311Z","end":"2026-05-16T09:24:01.679076Z","steps":["trace[659717468] 'process raft request'  (duration: 40.592766ms)","trace[659717468] 'compare'  (duration: 62.809164ms)"],"step_count":2}
{"level":"info","ts":"2026-05-16T09:24:02.255646Z","caller":"traceutil/trace.go:171","msg":"trace[1383074851] transaction","detail":"{read_only:false; response_revision:1602; number_of_response:1; }","duration":"137.940389ms","start":"2026-05-16T09:24:02.11768Z","end":"2026-05-16T09:24:02.255621Z","steps":["trace[1383074851] 'process raft request'  (duration: 137.774215ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:24:02.259881Z","caller":"traceutil/trace.go:171","msg":"trace[1918698475] transaction","detail":"{read_only:false; response_revision:1603; number_of_response:1; }","duration":"138.215056ms","start":"2026-05-16T09:24:02.121632Z","end":"2026-05-16T09:24:02.259847Z","steps":["trace[1918698475] 'process raft request'  (duration: 137.96023ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:24:11.378983Z","caller":"traceutil/trace.go:171","msg":"trace[1189946170] transaction","detail":"{read_only:false; response_revision:1642; number_of_response:1; }","duration":"124.605875ms","start":"2026-05-16T09:24:11.254351Z","end":"2026-05-16T09:24:11.378957Z","steps":["trace[1189946170] 'process raft request'  (duration: 124.464411ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:24:11.487394Z","caller":"traceutil/trace.go:171","msg":"trace[1887747110] transaction","detail":"{read_only:false; response_revision:1643; number_of_response:1; }","duration":"105.121673ms","start":"2026-05-16T09:24:11.382241Z","end":"2026-05-16T09:24:11.487363Z","steps":["trace[1887747110] 'process raft request'  (duration: 48.073127ms)","trace[1887747110] 'compare'  (duration: 56.839781ms)"],"step_count":2}
{"level":"info","ts":"2026-05-16T09:24:11.99908Z","caller":"traceutil/trace.go:171","msg":"trace[1825500832] transaction","detail":"{read_only:false; response_revision:1647; number_of_response:1; }","duration":"110.44455ms","start":"2026-05-16T09:24:11.88861Z","end":"2026-05-16T09:24:11.999054Z","steps":["trace[1825500832] 'process raft request'  (duration: 110.286717ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:24:12.319767Z","caller":"traceutil/trace.go:171","msg":"trace[248584151] transaction","detail":"{read_only:false; response_revision:1648; number_of_response:1; }","duration":"138.457701ms","start":"2026-05-16T09:24:12.18126Z","end":"2026-05-16T09:24:12.319717Z","steps":["trace[248584151] 'process raft request'  (duration: 70.085291ms)","trace[248584151] 'compare'  (duration: 68.158625ms)"],"step_count":2}
{"level":"info","ts":"2026-05-16T09:26:20.399452Z","caller":"traceutil/trace.go:171","msg":"trace[1242189256] linearizableReadLoop","detail":"{readStateIndex:2355; appliedIndex:2354; }","duration":"108.893069ms","start":"2026-05-16T09:26:20.290542Z","end":"2026-05-16T09:26:20.399435Z","steps":["trace[1242189256] 'read index received'  (duration: 108.723255ms)","trace[1242189256] 'applied index is now lower than readState.Index'  (duration: 169.184µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-16T09:26:20.399711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.147035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-05-16T09:26:20.399779Z","caller":"traceutil/trace.go:171","msg":"trace[1679829737] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2263; }","duration":"109.260818ms","start":"2026-05-16T09:26:20.290503Z","end":"2026-05-16T09:26:20.399764Z","steps":["trace[1679829737] 'agreement among raft nodes before linearized reading'  (duration: 109.016082ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:26:20.399933Z","caller":"traceutil/trace.go:171","msg":"trace[1999808989] transaction","detail":"{read_only:false; response_revision:2263; number_of_response:1; }","duration":"117.469127ms","start":"2026-05-16T09:26:20.28245Z","end":"2026-05-16T09:26:20.399919Z","steps":["trace[1999808989] 'process raft request'  (duration: 116.870722ms)"],"step_count":1}
{"level":"info","ts":"2026-05-16T09:26:20.538977Z","caller":"traceutil/trace.go:171","msg":"trace[981235899] transaction","detail":"{read_only:false; response_revision:2264; number_of_response:1; }","duration":"135.672758ms","start":"2026-05-16T09:26:20.403263Z","end":"2026-05-16T09:26:20.538936Z","steps":["trace[981235899] 'process raft request'  (duration: 80.713876ms)","trace[981235899] 'compare'  (duration: 54.615824ms)"],"step_count":2}
{"level":"info","ts":"2026-05-16T09:26:20.539048Z","caller":"traceutil/trace.go:171","msg":"trace[302899484] transaction","detail":"{read_only:false; response_revision:2265; number_of_response:1; }","duration":"135.40084ms","start":"2026-05-16T09:26:20.403607Z","end":"2026-05-16T09:26:20.539008Z","steps":["trace[302899484] 'process raft request'  (duration: 135.237876ms)"],"step_count":1}