{"level":"warn","ts":"2026-06-15T15:48:38.439905Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-15T15:48:38.440052Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.229: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.229:2380","--initial-cluster=instance=https://199.204.45.229:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.229:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.229:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-15T15:48:38.440182Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-15T15:48:38.440206Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-06-15T15:48:38.440236Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-15T15:48:38.44143Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"]} {"level":"info","ts":"2026-06-15T15:48:38.441569Z","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.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.229:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-15T15:48:38.446286Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.3398ms"} {"level":"info","ts":"2026-06-15T15:48:38.452403Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3ba9ae53cc4335db","cluster-id":"4ad2674607ff1d60"} {"level":"info","ts":"2026-06-15T15:48:38.452499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=()"} {"level":"info","ts":"2026-06-15T15:48:38.452523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 0"} {"level":"info","ts":"2026-06-15T15:48:38.452541Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3ba9ae53cc4335db [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-15T15:48:38.452555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 1"} {"level":"info","ts":"2026-06-15T15:48:38.452592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"warn","ts":"2026-06-15T15:48:38.461929Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-15T15:48:38.463478Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-15T15:48:38.464457Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-15T15:48:38.467452Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3ba9ae53cc4335db","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-15T15:48:38.467956Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3ba9ae53cc4335db","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-15T15:48:38.468043Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-15T15:48:38.468092Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-15T15:48:38.468102Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-15T15:48:38.468534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"info","ts":"2026-06-15T15:48:38.476538Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","added-peer-id":"3ba9ae53cc4335db","added-peer-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-06-15T15:48:38.4802Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-15T15:48:38.480325Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-06-15T15:48:38.480348Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-06-15T15:48:38.48172Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3ba9ae53cc4335db","initial-advertise-peer-urls":["https://199.204.45.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-15T15:48:38.481849Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-15T15:48:38.552784Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db is starting a new election at term 1"} {"level":"info","ts":"2026-06-15T15:48:38.552856Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became pre-candidate at term 1"} {"level":"info","ts":"2026-06-15T15:48:38.552884Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgPreVoteResp from 3ba9ae53cc4335db at term 1"} {"level":"info","ts":"2026-06-15T15:48:38.552904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became candidate at term 2"} {"level":"info","ts":"2026-06-15T15:48:38.552915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgVoteResp from 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-06-15T15:48:38.552931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became leader at term 2"} {"level":"info","ts":"2026-06-15T15:48:38.552945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3ba9ae53cc4335db elected leader 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-06-15T15:48:38.554866Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3ba9ae53cc4335db","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.229:2379]}","request-path":"/0/members/3ba9ae53cc4335db/attributes","cluster-id":"4ad2674607ff1d60","publish-timeout":"7s"} {"level":"info","ts":"2026-06-15T15:48:38.554934Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T15:48:38.555036Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T15:48:38.555159Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T15:48:38.555415Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-15T15:48:38.55551Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-15T15:48:38.55587Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T15:48:38.556042Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T15:48:38.556074Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T15:48:38.558009Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.229:2379"} {"level":"info","ts":"2026-06-15T15:48:38.558395Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-15T15:49:04.526966Z","caller":"traceutil/trace.go:171","msg":"trace[221156671] linearizableReadLoop","detail":"{readStateIndex:442; appliedIndex:441; }","duration":"281.80863ms","start":"2026-06-15T15:49:04.245128Z","end":"2026-06-15T15:49:04.526936Z","steps":["trace[221156671] 'read index received' (duration: 281.514505ms)","trace[221156671] 'applied index is now lower than readState.Index' (duration: 293.135µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:49:04.527036Z","caller":"traceutil/trace.go:171","msg":"trace[777897745] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"424.315655ms","start":"2026-06-15T15:49:04.102671Z","end":"2026-06-15T15:49:04.526987Z","steps":["trace[777897745] 'process raft request' (duration: 424.102231ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:49:04.527188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.000304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:49:04.527248Z","caller":"traceutil/trace.go:171","msg":"trace[1241414543] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:423; }","duration":"282.166787ms","start":"2026-06-15T15:49:04.245071Z","end":"2026-06-15T15:49:04.527238Z","steps":["trace[1241414543] 'agreement among raft nodes before linearized reading' (duration: 282.014584ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:49:04.527407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.404199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-15T15:49:04.527415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.950297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-15T15:49:04.527501Z","caller":"traceutil/trace.go:171","msg":"trace[496294249] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:423; }","duration":"169.549251ms","start":"2026-06-15T15:49:04.357928Z","end":"2026-06-15T15:49:04.527477Z","steps":["trace[496294249] 'agreement among raft nodes before linearized reading' (duration: 169.376228ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:49:04.527539Z","caller":"traceutil/trace.go:171","msg":"trace[955680433] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:423; }","duration":"256.125259ms","start":"2026-06-15T15:49:04.271374Z","end":"2026-06-15T15:49:04.5275Z","steps":["trace[955680433] 'agreement among raft nodes before linearized reading' (duration: 255.886605ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:49:04.527804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:49:04.102636Z","time spent":"424.493539ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T15:49:04.939166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.370302ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:49:04.939332Z","caller":"traceutil/trace.go:171","msg":"trace[1577372364] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:423; }","duration":"215.564616ms","start":"2026-06-15T15:49:04.723744Z","end":"2026-06-15T15:49:04.939309Z","steps":["trace[1577372364] 'range keys from in-memory index tree' (duration: 215.345241ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:49:04.939842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.464358ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T15:49:04.940053Z","caller":"traceutil/trace.go:171","msg":"trace[1563785130] linearizableReadLoop","detail":"{readStateIndex:444; appliedIndex:442; }","duration":"315.454727ms","start":"2026-06-15T15:49:04.62458Z","end":"2026-06-15T15:49:04.940035Z","steps":["trace[1563785130] 'read index received' (duration: 150.40991ms)","trace[1563785130] 'applied index is now lower than readState.Index' (duration: 165.043777ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:49:04.94016Z","caller":"traceutil/trace.go:171","msg":"trace[82915621] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"407.412155ms","start":"2026-06-15T15:49:04.532738Z","end":"2026-06-15T15:49:04.94015Z","steps":["trace[82915621] 'process raft request' (duration: 407.234372ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:49:04.940226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:49:04.532705Z","time spent":"407.486347ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T15:49:04.940295Z","caller":"traceutil/trace.go:171","msg":"trace[1035479813] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"409.078136ms","start":"2026-06-15T15:49:04.531182Z","end":"2026-06-15T15:49:04.940261Z","steps":["trace[1035479813] 'process raft request' (duration: 243.794654ms)","trace[1035479813] 'compare' (duration: 164.319914ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:49:04.940337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.548588ms","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-06-15T15:49:04.94042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:49:04.531165Z","time spent":"409.189438ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T15:49:04.940487Z","caller":"traceutil/trace.go:171","msg":"trace[263248123] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:425; }","duration":"280.723461ms","start":"2026-06-15T15:49:04.659718Z","end":"2026-06-15T15:49:04.940442Z","steps":["trace[263248123] 'agreement among raft nodes before linearized reading' (duration: 280.452956ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:49:04.940452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.831205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-15T15:49:04.941116Z","caller":"traceutil/trace.go:171","msg":"trace[916354283] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:425; }","duration":"316.565378ms","start":"2026-06-15T15:49:04.624534Z","end":"2026-06-15T15:49:04.941099Z","steps":["trace[916354283] 'agreement among raft nodes before linearized reading' (duration: 315.712893ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:49:04.941175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:49:04.624502Z","time spent":"316.65786ms","remote":"127.0.0.1:37406","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-06-15T15:49:05.242706Z","caller":"traceutil/trace.go:171","msg":"trace[834337414] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"298.520477ms","start":"2026-06-15T15:49:04.944153Z","end":"2026-06-15T15:49:05.242674Z","steps":["trace[834337414] 'process raft request' (duration: 294.157187ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:49:05.334444Z","caller":"traceutil/trace.go:171","msg":"trace[852619743] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"389.552938ms","start":"2026-06-15T15:49:04.944863Z","end":"2026-06-15T15:49:05.334416Z","steps":["trace[852619743] 'process raft request' (duration: 389.371884ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:49:05.334667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:49:04.944855Z","time spent":"389.68841ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T15:49:14.616417Z","caller":"traceutil/trace.go:171","msg":"trace[448201211] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"165.181394ms","start":"2026-06-15T15:49:14.451208Z","end":"2026-06-15T15:49:14.616389Z","steps":["trace[448201211] 'process raft request' (duration: 157.322397ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:49:14.617668Z","caller":"traceutil/trace.go:171","msg":"trace[1484951066] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"103.809187ms","start":"2026-06-15T15:49:14.513849Z","end":"2026-06-15T15:49:14.617658Z","steps":["trace[1484951066] 'process raft request' (duration: 103.714605ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:49:14.617706Z","caller":"traceutil/trace.go:171","msg":"trace[157710573] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"154.569294ms","start":"2026-06-15T15:49:14.463127Z","end":"2026-06-15T15:49:14.617697Z","steps":["trace[157710573] 'process raft request' (duration: 154.35247ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:49:20.939005Z","caller":"traceutil/trace.go:171","msg":"trace[1196038349] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:611; }","duration":"189.525913ms","start":"2026-06-15T15:49:20.749394Z","end":"2026-06-15T15:49:20.93892Z","steps":["trace[1196038349] 'read index received' (duration: 188.498623ms)","trace[1196038349] 'applied index is now lower than readState.Index' (duration: 1.02602ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:49:20.939036Z","caller":"traceutil/trace.go:171","msg":"trace[633245428] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"430.008676ms","start":"2026-06-15T15:49:20.508984Z","end":"2026-06-15T15:49:20.938993Z","steps":["trace[633245428] 'process raft request' (duration: 429.197242ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:49:20.939373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.92438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-cnld6\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-06-15T15:49:20.939389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:49:20.508954Z","time spent":"430.220171ms","remote":"127.0.0.1:37182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T15:49:20.939443Z","caller":"traceutil/trace.go:171","msg":"trace[2043616474] range","detail":"{range_begin:/registry/pods/kube-system/cilium-cnld6; range_end:; response_count:1; response_revision:585; }","duration":"190.086023ms","start":"2026-06-15T15:49:20.74933Z","end":"2026-06-15T15:49:20.939416Z","steps":["trace[2043616474] 'agreement among raft nodes before linearized reading' (duration: 189.799908ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:49:21.16609Z","caller":"traceutil/trace.go:171","msg":"trace[1886114117] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"211.109109ms","start":"2026-06-15T15:49:20.954943Z","end":"2026-06-15T15:49:21.166052Z","steps":["trace[1886114117] 'process raft request' (duration: 145.648546ms)","trace[1886114117] 'compare' (duration: 65.232019ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:49:21.166488Z","caller":"traceutil/trace.go:171","msg":"trace[322910089] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"154.437842ms","start":"2026-06-15T15:49:21.012025Z","end":"2026-06-15T15:49:21.166463Z","steps":["trace[322910089] 'process raft request' (duration: 153.962212ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:49:21.166714Z","caller":"traceutil/trace.go:171","msg":"trace[1473265848] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:612; }","duration":"118.781019ms","start":"2026-06-15T15:49:21.047575Z","end":"2026-06-15T15:49:21.166356Z","steps":["trace[1473265848] 'read index received' (duration: 53.031799ms)","trace[1473265848] 'applied index is now lower than readState.Index' (duration: 65.74791ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:49:21.167302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.695286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-15T15:49:21.16742Z","caller":"traceutil/trace.go:171","msg":"trace[574510527] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:587; }","duration":"119.869289ms","start":"2026-06-15T15:49:21.047523Z","end":"2026-06-15T15:49:21.167392Z","steps":["trace[574510527] 'agreement among raft nodes before linearized reading' (duration: 119.448741ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:49:21.676895Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880870102793828663,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-15T15:49:21.939523Z","caller":"traceutil/trace.go:171","msg":"trace[1339514243] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"764.837681ms","start":"2026-06-15T15:49:21.174641Z","end":"2026-06-15T15:49:21.939479Z","steps":["trace[1339514243] 'process raft request' (duration: 758.178205ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:49:21.939764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:49:21.174613Z","time spent":"765.011333ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T15:49:21.944096Z","caller":"traceutil/trace.go:171","msg":"trace[1867597693] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"766.876378ms","start":"2026-06-15T15:49:21.177189Z","end":"2026-06-15T15:49:21.944065Z","steps":["trace[1867597693] 'process raft request' (duration: 766.666964ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:49:21.944269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"768.024729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:49:21.944292Z","caller":"traceutil/trace.go:171","msg":"trace[952160669] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"706.383638ms","start":"2026-06-15T15:49:21.237888Z","end":"2026-06-15T15:49:21.944272Z","steps":["trace[952160669] 'process raft request' (duration: 706.128003ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:49:21.944331Z","caller":"traceutil/trace.go:171","msg":"trace[438346443] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:590; }","duration":"768.134921ms","start":"2026-06-15T15:49:21.176182Z","end":"2026-06-15T15:49:21.944317Z","steps":["trace[438346443] 'agreement among raft nodes before linearized reading' (duration: 768.04713ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:49:21.944385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:49:21.176154Z","time spent":"768.222663ms","remote":"127.0.0.1:37368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-06-15T15:49:21.944382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:49:21.237865Z","time spent":"706.464479ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T15:49:21.944453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:49:21.177173Z","time spent":"767.074412ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T15:49:21.944176Z","caller":"traceutil/trace.go:171","msg":"trace[756145783] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:614; }","duration":"767.920758ms","start":"2026-06-15T15:49:21.176238Z","end":"2026-06-15T15:49:21.944159Z","steps":["trace[756145783] 'read index received' (duration: 756.601114ms)","trace[756145783] 'applied index is now lower than readState.Index' (duration: 11.316884ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:49:21.944808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.982845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-15T15:49:21.94485Z","caller":"traceutil/trace.go:171","msg":"trace[349945319] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:590; }","duration":"632.080637ms","start":"2026-06-15T15:49:21.312758Z","end":"2026-06-15T15:49:21.944839Z","steps":["trace[349945319] 'agreement among raft nodes before linearized reading' (duration: 631.930813ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:49:21.944881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:49:21.312739Z","time spent":"632.135099ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-15T15:49:21.945022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.728046ms","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-06-15T15:49:21.944991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.604899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-15T15:49:21.945056Z","caller":"traceutil/trace.go:171","msg":"trace[651965396] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:590; }","duration":"521.813038ms","start":"2026-06-15T15:49:21.423235Z","end":"2026-06-15T15:49:21.945048Z","steps":["trace[651965396] 'agreement among raft nodes before linearized reading' (duration: 521.723016ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:49:21.945085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:49:21.423209Z","time spent":"521.869649ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-15T15:49:21.945095Z","caller":"traceutil/trace.go:171","msg":"trace[1762788434] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:590; }","duration":"134.765541ms","start":"2026-06-15T15:49:21.810304Z","end":"2026-06-15T15:49:21.94507Z","steps":["trace[1762788434] 'agreement among raft nodes before linearized reading' (duration: 134.530767ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:10.381018Z","caller":"traceutil/trace.go:171","msg":"trace[579761827] linearizableReadLoop","detail":"{readStateIndex:1001; appliedIndex:1000; }","duration":"147.216535ms","start":"2026-06-15T15:50:10.233774Z","end":"2026-06-15T15:50:10.38099Z","steps":["trace[579761827] 'read index received' (duration: 147.000651ms)","trace[579761827] 'applied index is now lower than readState.Index' (duration: 214.244µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:50:10.381206Z","caller":"traceutil/trace.go:171","msg":"trace[1202661059] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"237.890585ms","start":"2026-06-15T15:50:10.143302Z","end":"2026-06-15T15:50:10.381193Z","steps":["trace[1202661059] 'process raft request' (duration: 237.511257ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:10.381473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.680974ms","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-06-15T15:50:10.381537Z","caller":"traceutil/trace.go:171","msg":"trace[1290147482] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:960; }","duration":"147.806737ms","start":"2026-06-15T15:50:10.233717Z","end":"2026-06-15T15:50:10.381524Z","steps":["trace[1290147482] 'agreement among raft nodes before linearized reading' (duration: 147.628204ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:10.381631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.84971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:50:10.381744Z","caller":"traceutil/trace.go:171","msg":"trace[34476219] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:960; }","duration":"137.026753ms","start":"2026-06-15T15:50:10.244693Z","end":"2026-06-15T15:50:10.38172Z","steps":["trace[34476219] 'agreement among raft nodes before linearized reading' (duration: 136.82177ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:10.381888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.113428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-15T15:50:10.38193Z","caller":"traceutil/trace.go:171","msg":"trace[1445243909] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:960; }","duration":"125.1754ms","start":"2026-06-15T15:50:10.25674Z","end":"2026-06-15T15:50:10.381915Z","steps":["trace[1445243909] 'agreement among raft nodes before linearized reading' (duration: 125.064118ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:11.611104Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880870102793829421,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-15T15:50:11.644059Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.233332451s","expected-duration":"1s"} {"level":"info","ts":"2026-06-15T15:50:11.644537Z","caller":"traceutil/trace.go:171","msg":"trace[1042667857] linearizableReadLoop","detail":"{readStateIndex:1005; appliedIndex:1002; }","duration":"534.238512ms","start":"2026-06-15T15:50:11.110277Z","end":"2026-06-15T15:50:11.644516Z","steps":["trace[1042667857] 'read index received' (duration: 533.994878ms)","trace[1042667857] 'applied index is now lower than readState.Index' (duration: 242.584µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:50:11.644678Z","caller":"traceutil/trace.go:171","msg":"trace[638612630] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"1.257365134s","start":"2026-06-15T15:50:10.387303Z","end":"2026-06-15T15:50:11.644668Z","steps":["trace[638612630] 'process raft request' (duration: 1.2571394s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:11.64478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:10.387281Z","time spent":"1.257421165s","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T15:50:11.644818Z","caller":"traceutil/trace.go:171","msg":"trace[1694833788] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"1.257483396s","start":"2026-06-15T15:50:10.387134Z","end":"2026-06-15T15:50:11.644617Z","steps":["trace[1694833788] 'process raft request' (duration: 1.25715741s)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:11.645045Z","caller":"traceutil/trace.go:171","msg":"trace[1708625043] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"1.257326433s","start":"2026-06-15T15:50:10.387697Z","end":"2026-06-15T15:50:11.645024Z","steps":["trace[1708625043] 'process raft request' (duration: 1.256778823s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:11.645297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:10.387115Z","time spent":"1.257940835s","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T15:50:11.644973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.652359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-15T15:50:11.645443Z","caller":"traceutil/trace.go:171","msg":"trace[1756482507] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:964; }","duration":"535.1992ms","start":"2026-06-15T15:50:11.110229Z","end":"2026-06-15T15:50:11.645428Z","steps":["trace[1756482507] 'agreement among raft nodes before linearized reading' (duration: 534.459256ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:11.645474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:11.110205Z","time spent":"535.257422ms","remote":"127.0.0.1:37480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":16,"response size":29,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"warn","ts":"2026-06-15T15:50:11.64628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:10.387679Z","time spent":"1.257496197s","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T15:50:12.109483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.631761ms","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-06-15T15:50:12.109548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.49664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-15T15:50:12.109591Z","caller":"traceutil/trace.go:171","msg":"trace[613005590] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:964; }","duration":"357.857037ms","start":"2026-06-15T15:50:11.75171Z","end":"2026-06-15T15:50:12.109567Z","steps":["trace[613005590] 'range keys from in-memory index tree' (duration: 357.318326ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:12.109648Z","caller":"traceutil/trace.go:171","msg":"trace[1184763753] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:964; }","duration":"296.657793ms","start":"2026-06-15T15:50:11.812967Z","end":"2026-06-15T15:50:12.109625Z","steps":["trace[1184763753] 'range keys from in-memory index tree' (duration: 296.199905ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:12.109659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:11.751679Z","time spent":"357.960758ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-15T15:50:38.691326Z","caller":"traceutil/trace.go:171","msg":"trace[1744293153] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"390.118649ms","start":"2026-06-15T15:50:38.301179Z","end":"2026-06-15T15:50:38.691297Z","steps":["trace[1744293153] 'process raft request' (duration: 389.970546ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:38.691512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:38.301155Z","time spent":"390.257421ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T15:50:39.215362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.131107ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T15:50:39.215511Z","caller":"traceutil/trace.go:171","msg":"trace[1011037663] linearizableReadLoop","detail":"{readStateIndex:1100; appliedIndex:1099; }","duration":"583.357805ms","start":"2026-06-15T15:50:38.632123Z","end":"2026-06-15T15:50:39.215481Z","steps":["trace[1011037663] 'read index received' (duration: 59.432799ms)","trace[1011037663] 'applied index is now lower than readState.Index' (duration: 523.922946ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:50:39.215658Z","caller":"traceutil/trace.go:171","msg":"trace[543168174] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"623.877042ms","start":"2026-06-15T15:50:38.591767Z","end":"2026-06-15T15:50:39.215644Z","steps":["trace[543168174] 'process raft request' (duration: 230.324756ms)","trace[543168174] 'compare' (duration: 392.723759ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:50:39.215733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:38.591734Z","time spent":"623.958464ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T15:50:39.215828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.883647ms","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-06-15T15:50:39.215912Z","caller":"traceutil/trace.go:171","msg":"trace[209214295] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1053; }","duration":"339.03168ms","start":"2026-06-15T15:50:38.87686Z","end":"2026-06-15T15:50:39.215891Z","steps":["trace[209214295] 'agreement among raft nodes before linearized reading' (duration: 338.894988ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:39.215987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:38.876832Z","time spent":"339.130932ms","remote":"127.0.0.1:37338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-06-15T15:50:39.216191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.062438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-15T15:50:39.216237Z","caller":"traceutil/trace.go:171","msg":"trace[651876019] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1053; }","duration":"584.141409ms","start":"2026-06-15T15:50:38.632085Z","end":"2026-06-15T15:50:39.216226Z","steps":["trace[651876019] 'agreement among raft nodes before linearized reading' (duration: 583.927625ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:39.216264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:38.632072Z","time spent":"584.18545ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-15T15:50:39.542406Z","caller":"traceutil/trace.go:171","msg":"trace[1066010103] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"321.616336ms","start":"2026-06-15T15:50:39.22075Z","end":"2026-06-15T15:50:39.542367Z","steps":["trace[1066010103] 'process raft request' (duration: 293.456397ms)","trace[1066010103] 'compare' (duration: 27.972696ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:50:39.542697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:39.220732Z","time spent":"321.77176ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T15:50:41.119026Z","caller":"traceutil/trace.go:171","msg":"trace[1730760407] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"417.179248ms","start":"2026-06-15T15:50:40.701821Z","end":"2026-06-15T15:50:41.119Z","steps":["trace[1730760407] 'process raft request' (duration: 416.970804ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:41.119236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:40.70179Z","time spent":"417.317931ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T15:50:41.458659Z","caller":"traceutil/trace.go:171","msg":"trace[1440582716] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"236.307551ms","start":"2026-06-15T15:50:41.222271Z","end":"2026-06-15T15:50:41.458578Z","steps":["trace[1440582716] 'process raft request' (duration: 142.450052ms)","trace[1440582716] 'compare' (duration: 93.692206ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:50:41.672455Z","caller":"traceutil/trace.go:171","msg":"trace[468010996] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"119.517871ms","start":"2026-06-15T15:50:41.552908Z","end":"2026-06-15T15:50:41.672426Z","steps":["trace[468010996] 'process raft request' (duration: 88.13472ms)","trace[468010996] 'compare' (duration: 31.252339ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:50:42.303185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.133026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-15T15:50:42.303304Z","caller":"traceutil/trace.go:171","msg":"trace[1147540900] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1061; }","duration":"370.29042ms","start":"2026-06-15T15:50:41.932987Z","end":"2026-06-15T15:50:42.303277Z","steps":["trace[1147540900] 'range keys from in-memory index tree' (duration: 370.005324ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:42.303335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.854922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-15T15:50:42.303444Z","caller":"traceutil/trace.go:171","msg":"trace[425391444] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1061; }","duration":"320.027026ms","start":"2026-06-15T15:50:41.983397Z","end":"2026-06-15T15:50:42.303424Z","steps":["trace[425391444] 'range keys from in-memory index tree' (duration: 319.643658ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:42.303575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:41.98337Z","time spent":"320.191659ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-15T15:50:42.303367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:41.932969Z","time spent":"370.382672ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-15T15:50:42.303717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.355474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-15T15:50:42.303787Z","caller":"traceutil/trace.go:171","msg":"trace[739048253] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1061; }","duration":"355.007256ms","start":"2026-06-15T15:50:41.948758Z","end":"2026-06-15T15:50:42.303765Z","steps":["trace[739048253] 'range keys from in-memory index tree' (duration: 354.184391ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:42.303833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:41.948745Z","time spent":"355.074547ms","remote":"127.0.0.1:37406","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-06-15T15:50:42.423488Z","caller":"traceutil/trace.go:171","msg":"trace[195441861] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"113.635039ms","start":"2026-06-15T15:50:42.309711Z","end":"2026-06-15T15:50:42.423346Z","steps":["trace[195441861] 'process raft request' (duration: 113.423575ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:42.477963Z","caller":"traceutil/trace.go:171","msg":"trace[1224604884] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"168.039642ms","start":"2026-06-15T15:50:42.309865Z","end":"2026-06-15T15:50:42.477904Z","steps":["trace[1224604884] 'process raft request' (duration: 167.983521ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:42.478001Z","caller":"traceutil/trace.go:171","msg":"trace[745667546] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"168.159084ms","start":"2026-06-15T15:50:42.30981Z","end":"2026-06-15T15:50:42.477969Z","steps":["trace[745667546] 'process raft request' (duration: 167.893719ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:43.55999Z","caller":"traceutil/trace.go:171","msg":"trace[1159224518] linearizableReadLoop","detail":"{readStateIndex:1113; appliedIndex:1112; }","duration":"314.611441ms","start":"2026-06-15T15:50:43.245276Z","end":"2026-06-15T15:50:43.559888Z","steps":["trace[1159224518] 'read index received' (duration: 314.264405ms)","trace[1159224518] 'applied index is now lower than readState.Index' (duration: 345.796µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:50:43.560062Z","caller":"traceutil/trace.go:171","msg":"trace[687454309] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"430.962782ms","start":"2026-06-15T15:50:43.129043Z","end":"2026-06-15T15:50:43.560006Z","steps":["trace[687454309] 'process raft request' (duration: 430.537504ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:43.560335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:43.12902Z","time spent":"431.223328ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T15:50:43.560457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.156322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:50:43.560845Z","caller":"traceutil/trace.go:171","msg":"trace[1841379891] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1065; }","duration":"315.55582ms","start":"2026-06-15T15:50:43.245199Z","end":"2026-06-15T15:50:43.560755Z","steps":["trace[1841379891] 'agreement among raft nodes before linearized reading' (duration: 315.058221ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:50:43.561009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:50:43.245169Z","time spent":"315.789364ms","remote":"127.0.0.1:37076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-15T15:50:43.613014Z","caller":"traceutil/trace.go:171","msg":"trace[1764599396] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"147.252073ms","start":"2026-06-15T15:50:43.465712Z","end":"2026-06-15T15:50:43.612964Z","steps":["trace[1764599396] 'process raft request' (duration: 146.943057ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:55.950373Z","caller":"traceutil/trace.go:171","msg":"trace[1997770145] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"195.800514ms","start":"2026-06-15T15:50:55.754532Z","end":"2026-06-15T15:50:55.950333Z","steps":["trace[1997770145] 'process raft request' (duration: 106.697885ms)","trace[1997770145] 'compare' (duration: 88.942316ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:50:56.709205Z","caller":"traceutil/trace.go:171","msg":"trace[1340279185] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"108.764696ms","start":"2026-06-15T15:50:56.600411Z","end":"2026-06-15T15:50:56.709176Z","steps":["trace[1340279185] 'process raft request' (duration: 108.561882ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:50:56.714051Z","caller":"traceutil/trace.go:171","msg":"trace[914365675] transaction","detail":"{read_only:false; response_revision:1110; number_of_response:1; }","duration":"113.253381ms","start":"2026-06-15T15:50:56.60076Z","end":"2026-06-15T15:50:56.714013Z","steps":["trace[914365675] 'process raft request' (duration: 112.950325ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:03.25698Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880870102793829970,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-15T15:51:03.653289Z","caller":"traceutil/trace.go:171","msg":"trace[2057443846] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"910.898933ms","start":"2026-06-15T15:51:02.742351Z","end":"2026-06-15T15:51:03.65325Z","steps":["trace[2057443846] 'process raft request' (duration: 910.6991ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:03.653461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:02.742335Z","time spent":"911.035708ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T15:51:04.830173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:03.736203Z","time spent":"1.093960334s","remote":"127.0.0.1:56594","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-15T15:51:04.830431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.954831ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:51:04.830635Z","caller":"traceutil/trace.go:171","msg":"trace[1451760898] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1180; }","duration":"106.151275ms","start":"2026-06-15T15:51:04.724426Z","end":"2026-06-15T15:51:04.830578Z","steps":["trace[1451760898] 'range keys from in-memory index tree' (duration: 105.672656ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:51:04.832113Z","caller":"traceutil/trace.go:171","msg":"trace[1461500863] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"838.852493ms","start":"2026-06-15T15:51:03.993233Z","end":"2026-06-15T15:51:04.832085Z","steps":["trace[1461500863] 'process raft request' (duration: 838.814632ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:51:04.832308Z","caller":"traceutil/trace.go:171","msg":"trace[2014983122] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"2.08894086s","start":"2026-06-15T15:51:02.743334Z","end":"2026-06-15T15:51:04.832275Z","steps":["trace[2014983122] 'process raft request' (duration: 2.033234862s)","trace[2014983122] 'compare' (duration: 53.495555ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:51:04.832358Z","caller":"traceutil/trace.go:171","msg":"trace[1219506976] linearizableReadLoop","detail":"{readStateIndex:1235; appliedIndex:1233; }","duration":"2.075910741s","start":"2026-06-15T15:51:02.756408Z","end":"2026-06-15T15:51:04.832319Z","steps":["trace[1219506976] 'read index received' (duration: 896.704082ms)","trace[1219506976] 'applied index is now lower than readState.Index' (duration: 1.179201519s)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:51:04.832467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:02.743309Z","time spent":"2.089065023s","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T15:51:04.832684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.911653822s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:51:04.832771Z","caller":"traceutil/trace.go:171","msg":"trace[716109332] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"854.32971ms","start":"2026-06-15T15:51:03.978427Z","end":"2026-06-15T15:51:04.832756Z","steps":["trace[716109332] 'process raft request' (duration: 853.542114ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:04.832815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"813.829453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-15T15:51:04.832855Z","caller":"traceutil/trace.go:171","msg":"trace[700466304] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1183; }","duration":"813.925384ms","start":"2026-06-15T15:51:04.018915Z","end":"2026-06-15T15:51:04.83284Z","steps":["trace[700466304] 'agreement among raft nodes before linearized reading' (duration: 813.838383ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:04.832864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:03.9784Z","time spent":"854.423261ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T15:51:04.832903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:04.018885Z","time spent":"814.010416ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-15T15:51:04.832941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.033923302s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:51:04.832746Z","caller":"traceutil/trace.go:171","msg":"trace[841131096] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1183; }","duration":"1.911786895s","start":"2026-06-15T15:51:02.920947Z","end":"2026-06-15T15:51:04.832734Z","steps":["trace[841131096] 'agreement among raft nodes before linearized reading' (duration: 1.911674642s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:04.833009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:02.92092Z","time spent":"1.912072989s","remote":"127.0.0.1:40906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-15T15:51:04.833156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.084195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T15:51:04.832697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.076269697s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-15T15:51:04.833196Z","caller":"traceutil/trace.go:171","msg":"trace[1213663838] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1183; }","duration":"588.175637ms","start":"2026-06-15T15:51:04.245009Z","end":"2026-06-15T15:51:04.833185Z","steps":["trace[1213663838] 'agreement among raft nodes before linearized reading' (duration: 588.117386ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:51:04.833209Z","caller":"traceutil/trace.go:171","msg":"trace[570288448] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1183; }","duration":"2.076802697s","start":"2026-06-15T15:51:02.756393Z","end":"2026-06-15T15:51:04.833196Z","steps":["trace[570288448] 'agreement among raft nodes before linearized reading' (duration: 2.076111224s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:04.833232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:04.244987Z","time spent":"588.238979ms","remote":"127.0.0.1:37076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-15T15:51:04.833246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:02.756338Z","time spent":"2.076897039s","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-15T15:51:04.833693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.045809551s","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-06-15T15:51:04.833738Z","caller":"traceutil/trace.go:171","msg":"trace[571281217] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1183; }","duration":"1.045908973s","start":"2026-06-15T15:51:03.787819Z","end":"2026-06-15T15:51:04.833728Z","steps":["trace[571281217] 'agreement among raft nodes before linearized reading' (duration: 1.045731109s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:04.833773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:03.787794Z","time spent":"1.045968445s","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-15T15:51:04.832976Z","caller":"traceutil/trace.go:171","msg":"trace[67250542] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:1183; }","duration":"1.034100817s","start":"2026-06-15T15:51:03.798865Z","end":"2026-06-15T15:51:04.832965Z","steps":["trace[67250542] 'agreement among raft nodes before linearized reading' (duration: 1.033940004s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:04.834376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:03.798846Z","time spent":"1.035519774s","remote":"127.0.0.1:40898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-15T15:51:04.834735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:03.993214Z","time spent":"838.967865ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T15:51:16.994989Z","caller":"traceutil/trace.go:171","msg":"trace[2071297778] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"110.662332ms","start":"2026-06-15T15:51:16.884289Z","end":"2026-06-15T15:51:16.994951Z","steps":["trace[2071297778] 'process raft request' (duration: 110.425747ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:51:26.319112Z","caller":"traceutil/trace.go:171","msg":"trace[185338057] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"545.037099ms","start":"2026-06-15T15:51:25.774046Z","end":"2026-06-15T15:51:26.319083Z","steps":["trace[185338057] 'process raft request' (duration: 544.854276ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:26.319288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:25.774016Z","time spent":"545.179712ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T15:51:27.310932Z","caller":"traceutil/trace.go:171","msg":"trace[961608263] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"147.56151ms","start":"2026-06-15T15:51:27.163339Z","end":"2026-06-15T15:51:27.3109Z","steps":["trace[961608263] 'process raft request' (duration: 147.329916ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:27.909548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.33626ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-15T15:51:27.90979Z","caller":"traceutil/trace.go:171","msg":"trace[1194355945] linearizableReadLoop","detail":"{readStateIndex:1347; appliedIndex:1345; }","duration":"724.999397ms","start":"2026-06-15T15:51:27.184773Z","end":"2026-06-15T15:51:27.909772Z","steps":["trace[1194355945] 'read index received' (duration: 125.888577ms)","trace[1194355945] 'applied index is now lower than readState.Index' (duration: 599.10932ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:51:27.910447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.358681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:51:27.910498Z","caller":"traceutil/trace.go:171","msg":"trace[1467180683] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1289; }","duration":"665.445002ms","start":"2026-06-15T15:51:27.24504Z","end":"2026-06-15T15:51:27.910485Z","steps":["trace[1467180683] 'agreement among raft nodes before linearized reading' (duration: 665.319309ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:27.910536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:27.245029Z","time spent":"665.498884ms","remote":"127.0.0.1:37076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-15T15:51:27.910535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"717.30739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"info","ts":"2026-06-15T15:51:27.910663Z","caller":"traceutil/trace.go:171","msg":"trace[785739992] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1289; }","duration":"717.452184ms","start":"2026-06-15T15:51:27.193188Z","end":"2026-06-15T15:51:27.91064Z","steps":["trace[785739992] 'agreement among raft nodes before linearized reading' (duration: 717.078776ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:27.910655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.075088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-06-15T15:51:27.910663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.041447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-15T15:51:27.910719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:27.193158Z","time spent":"717.551355ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":494,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-06-15T15:51:27.910765Z","caller":"traceutil/trace.go:171","msg":"trace[1555506349] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1289; }","duration":"684.24211ms","start":"2026-06-15T15:51:27.226494Z","end":"2026-06-15T15:51:27.910736Z","steps":["trace[1555506349] 'agreement among raft nodes before linearized reading' (duration: 683.899713ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:51:27.910774Z","caller":"traceutil/trace.go:171","msg":"trace[609841228] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1289; }","duration":"684.229081ms","start":"2026-06-15T15:51:27.226518Z","end":"2026-06-15T15:51:27.910747Z","steps":["trace[609841228] 'agreement among raft nodes before linearized reading' (duration: 683.856763ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:27.910782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"725.969375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-06-15T15:51:27.910826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:27.226476Z","time spent":"684.339783ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-15T15:51:27.910792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.210191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-15T15:51:27.910055Z","caller":"traceutil/trace.go:171","msg":"trace[584763169] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"642.74235ms","start":"2026-06-15T15:51:27.267299Z","end":"2026-06-15T15:51:27.910041Z","steps":["trace[584763169] 'process raft request' (duration: 642.346572ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:51:27.910893Z","caller":"traceutil/trace.go:171","msg":"trace[492947972] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1289; }","duration":"726.139369ms","start":"2026-06-15T15:51:27.184729Z","end":"2026-06-15T15:51:27.910868Z","steps":["trace[492947972] 'agreement among raft nodes before linearized reading' (duration: 725.71455ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:51:27.910927Z","caller":"traceutil/trace.go:171","msg":"trace[2015753045] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1289; }","duration":"610.452435ms","start":"2026-06-15T15:51:27.300447Z","end":"2026-06-15T15:51:27.910899Z","steps":["trace[2015753045] 'agreement among raft nodes before linearized reading' (duration: 610.15226ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:27.910823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:27.226464Z","time spent":"684.348983ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-15T15:51:27.911005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:27.300413Z","time spent":"610.578767ms","remote":"127.0.0.1:40930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-15T15:51:27.910948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:27.184708Z","time spent":"726.23253ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-15T15:51:27.911079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.447515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-15T15:51:27.911114Z","caller":"traceutil/trace.go:171","msg":"trace[577632247] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1289; }","duration":"684.563667ms","start":"2026-06-15T15:51:27.226539Z","end":"2026-06-15T15:51:27.911103Z","steps":["trace[577632247] 'agreement among raft nodes before linearized reading' (duration: 684.452985ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:27.911145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:27.226508Z","time spent":"684.625098ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-15T15:51:27.911461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:27.267258Z","time spent":"643.669698ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T15:51:28.128585Z","caller":"traceutil/trace.go:171","msg":"trace[1893768966] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"213.698389ms","start":"2026-06-15T15:51:27.914854Z","end":"2026-06-15T15:51:28.128552Z","steps":["trace[1893768966] 'process raft request' (duration: 185.454631ms)","trace[1893768966] 'compare' (duration: 28.096165ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:51:28.210118Z","caller":"traceutil/trace.go:171","msg":"trace[1813490111] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"294.113502ms","start":"2026-06-15T15:51:27.91597Z","end":"2026-06-15T15:51:28.210083Z","steps":["trace[1813490111] 'process raft request' (duration: 293.874677ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:51:28.210261Z","caller":"traceutil/trace.go:171","msg":"trace[2046790660] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"294.189023ms","start":"2026-06-15T15:51:27.916021Z","end":"2026-06-15T15:51:28.21021Z","steps":["trace[2046790660] 'process raft request' (duration: 293.966219ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:51:28.210447Z","caller":"traceutil/trace.go:171","msg":"trace[720693395] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"293.918098ms","start":"2026-06-15T15:51:27.916517Z","end":"2026-06-15T15:51:28.210435Z","steps":["trace[720693395] 'process raft request' (duration: 293.503139ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:51:28.210666Z","caller":"traceutil/trace.go:171","msg":"trace[1854085523] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"293.232265ms","start":"2026-06-15T15:51:27.917424Z","end":"2026-06-15T15:51:28.210656Z","steps":["trace[1854085523] 'process raft request' (duration: 292.9652ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:28.640289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.749285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-15T15:51:28.640386Z","caller":"traceutil/trace.go:171","msg":"trace[1583878682] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1295; }","duration":"188.930498ms","start":"2026-06-15T15:51:28.451437Z","end":"2026-06-15T15:51:28.640367Z","steps":["trace[1583878682] 'count revisions from in-memory index tree' (duration: 188.567512ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:51:29.04729Z","caller":"traceutil/trace.go:171","msg":"trace[1724258711] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"110.044716ms","start":"2026-06-15T15:51:28.937214Z","end":"2026-06-15T15:51:29.047258Z","steps":["trace[1724258711] 'process raft request' (duration: 109.820811ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:51:35.968176Z","caller":"traceutil/trace.go:171","msg":"trace[921808033] linearizableReadLoop","detail":"{readStateIndex:1407; appliedIndex:1406; }","duration":"143.052494ms","start":"2026-06-15T15:51:35.825096Z","end":"2026-06-15T15:51:35.968149Z","steps":["trace[921808033] 'read index received' (duration: 142.86306ms)","trace[921808033] 'applied index is now lower than readState.Index' (duration: 188.324µs)"],"step_count":2} {"level":"warn","ts":"2026-06-15T15:51:35.968346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.195927ms","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-06-15T15:51:35.968385Z","caller":"traceutil/trace.go:171","msg":"trace[391228945] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1347; }","duration":"143.342861ms","start":"2026-06-15T15:51:35.82503Z","end":"2026-06-15T15:51:35.968373Z","steps":["trace[391228945] 'agreement among raft nodes before linearized reading' (duration: 143.220738ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:51:35.968356Z","caller":"traceutil/trace.go:171","msg":"trace[147066598] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"418.363316ms","start":"2026-06-15T15:51:35.549934Z","end":"2026-06-15T15:51:35.968298Z","steps":["trace[147066598] 'process raft request' (duration: 418.058411ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:35.968763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:35.549911Z","time spent":"418.53601ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T15:51:36.55378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.500649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:51:36.554463Z","caller":"traceutil/trace.go:171","msg":"trace[1363772018] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1347; }","duration":"220.676623ms","start":"2026-06-15T15:51:36.333186Z","end":"2026-06-15T15:51:36.553863Z","steps":["trace[1363772018] 'count revisions from in-memory index tree' (duration: 220.413928ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:36.5554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.626947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T15:51:36.555457Z","caller":"traceutil/trace.go:171","msg":"trace[383461596] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1347; }","duration":"309.727848ms","start":"2026-06-15T15:51:36.245716Z","end":"2026-06-15T15:51:36.555444Z","steps":["trace[383461596] 'range keys from in-memory index tree' (duration: 309.570526ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:36.555491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:36.245695Z","time spent":"309.786139ms","remote":"127.0.0.1:37076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-15T15:51:36.55557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.948657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-15T15:51:36.555418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.246905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-15T15:51:36.555655Z","caller":"traceutil/trace.go:171","msg":"trace[1120311317] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1347; }","duration":"306.056939ms","start":"2026-06-15T15:51:36.249583Z","end":"2026-06-15T15:51:36.55564Z","steps":["trace[1120311317] 'range keys from in-memory index tree' (duration: 305.817254ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T15:51:36.555689Z","caller":"traceutil/trace.go:171","msg":"trace[1230386615] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1347; }","duration":"304.51305ms","start":"2026-06-15T15:51:36.251147Z","end":"2026-06-15T15:51:36.55566Z","steps":["trace[1230386615] 'range keys from in-memory index tree' (duration: 304.141292ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:36.555742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.300884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-06-15T15:51:36.555746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:36.249564Z","time spent":"306.171961ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-15T15:51:36.555786Z","caller":"traceutil/trace.go:171","msg":"trace[548255957] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1347; }","duration":"305.357135ms","start":"2026-06-15T15:51:36.250417Z","end":"2026-06-15T15:51:36.555774Z","steps":["trace[548255957] 'range keys from in-memory index tree' (duration: 305.207572ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:36.55579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:36.251142Z","time spent":"304.613081ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-15T15:51:36.555819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:36.25041Z","time spent":"305.402535ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-15T15:51:36.555466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.458258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-15T15:51:36.555892Z","caller":"traceutil/trace.go:171","msg":"trace[1647191909] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1347; }","duration":"304.930998ms","start":"2026-06-15T15:51:36.250947Z","end":"2026-06-15T15:51:36.555878Z","steps":["trace[1647191909] 'range keys from in-memory index tree' (duration: 304.321826ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:51:36.555945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T15:51:36.250942Z","time spent":"304.988889ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-15T15:52:41.085347Z","caller":"traceutil/trace.go:171","msg":"trace[572545064] transaction","detail":"{read_only:false; response_revision:1645; number_of_response:1; }","duration":"110.871987ms","start":"2026-06-15T15:52:40.974445Z","end":"2026-06-15T15:52:41.085317Z","steps":["trace[572545064] 'process raft request' (duration: 62.932992ms)","trace[572545064] 'compare' (duration: 47.725901ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:52:41.08552Z","caller":"traceutil/trace.go:171","msg":"trace[1272647750] linearizableReadLoop","detail":"{readStateIndex:1719; appliedIndex:1717; }","duration":"102.562158ms","start":"2026-06-15T15:52:40.98291Z","end":"2026-06-15T15:52:41.085472Z","steps":["trace[1272647750] 'read index received' (duration: 54.442079ms)","trace[1272647750] 'applied index is now lower than readState.Index' (duration: 48.116419ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T15:52:41.085676Z","caller":"traceutil/trace.go:171","msg":"trace[1482488637] transaction","detail":"{read_only:false; response_revision:1646; number_of_response:1; }","duration":"108.336098ms","start":"2026-06-15T15:52:40.977328Z","end":"2026-06-15T15:52:41.085664Z","steps":["trace[1482488637] 'process raft request' (duration: 107.939081ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:52:41.085982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.234701ms","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-06-15T15:52:41.086013Z","caller":"traceutil/trace.go:171","msg":"trace[1513510314] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1646; }","duration":"103.308383ms","start":"2026-06-15T15:52:40.982697Z","end":"2026-06-15T15:52:41.086005Z","steps":["trace[1513510314] 'agreement among raft nodes before linearized reading' (duration: 103.105049ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T15:52:41.086117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.257763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-15T15:52:41.086182Z","caller":"traceutil/trace.go:171","msg":"trace[665564234] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1646; }","duration":"102.427316ms","start":"2026-06-15T15:52:40.983738Z","end":"2026-06-15T15:52:41.086165Z","steps":["trace[665564234] 'agreement among raft nodes before linearized reading' (duration: 102.1515ms)"],"step_count":1}