{"level":"warn","ts":"2026-05-28T07:51:44.503748Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-28T07:51:44.503828Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.222: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.222:2380","--initial-cluster=instance=https://199.204.45.222:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.222:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.222:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-28T07:51:44.503893Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-28T07:51:44.503907Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-05-28T07:51:44.503925Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-28T07:51:44.504479Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"]} {"level":"info","ts":"2026-05-28T07:51:44.504552Z","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":16,"max-cpu-available":16,"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.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.222:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-28T07:51:44.511516Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.925651ms"} {"level":"info","ts":"2026-05-28T07:51:44.518829Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"380f6760faea5f9e","cluster-id":"b87e8aca83a17eab"} {"level":"info","ts":"2026-05-28T07:51:44.518936Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=()"} {"level":"info","ts":"2026-05-28T07:51:44.518972Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 0"} {"level":"info","ts":"2026-05-28T07:51:44.518992Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 380f6760faea5f9e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-28T07:51:44.519009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 1"} {"level":"info","ts":"2026-05-28T07:51:44.519067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"warn","ts":"2026-05-28T07:51:44.530005Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-28T07:51:44.531553Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-28T07:51:44.53288Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-28T07:51:44.535849Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"380f6760faea5f9e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-28T07:51:44.536034Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"380f6760faea5f9e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-28T07:51:44.536203Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-28T07:51:44.537059Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-28T07:51:44.537189Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-28T07:51:44.538546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"info","ts":"2026-05-28T07:51:44.538751Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","added-peer-id":"380f6760faea5f9e","added-peer-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-05-28T07:51:44.54047Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-28T07:51:44.540761Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"380f6760faea5f9e","initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-28T07:51:44.540806Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-28T07:51:44.540843Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-05-28T07:51:44.540889Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-05-28T07:51:44.720215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e is starting a new election at term 1"} {"level":"info","ts":"2026-05-28T07:51:44.720288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became pre-candidate at term 1"} {"level":"info","ts":"2026-05-28T07:51:44.720345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgPreVoteResp from 380f6760faea5f9e at term 1"} {"level":"info","ts":"2026-05-28T07:51:44.72038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became candidate at term 2"} {"level":"info","ts":"2026-05-28T07:51:44.720404Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgVoteResp from 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-05-28T07:51:44.720431Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became leader at term 2"} {"level":"info","ts":"2026-05-28T07:51:44.720455Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 380f6760faea5f9e elected leader 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-05-28T07:51:44.722503Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"380f6760faea5f9e","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.222:2379]}","request-path":"/0/members/380f6760faea5f9e/attributes","cluster-id":"b87e8aca83a17eab","publish-timeout":"7s"} {"level":"info","ts":"2026-05-28T07:51:44.722522Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-28T07:51:44.722548Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T07:51:44.722648Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-28T07:51:44.723019Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-28T07:51:44.723066Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-28T07:51:44.723365Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T07:51:44.723491Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T07:51:44.723526Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T07:51:44.724997Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.222:2379"} {"level":"info","ts":"2026-05-28T07:51:44.726619Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-28T07:52:21.677945Z","caller":"traceutil/trace.go:171","msg":"trace[2087798902] linearizableReadLoop","detail":"{readStateIndex:508; appliedIndex:507; }","duration":"148.63024ms","start":"2026-05-28T07:52:21.529289Z","end":"2026-05-28T07:52:21.67792Z","steps":["trace[2087798902] 'read index received' (duration: 148.258353ms)","trace[2087798902] 'applied index is now lower than readState.Index' (duration: 370.967µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T07:52:21.67806Z","caller":"traceutil/trace.go:171","msg":"trace[623896440] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"168.559872ms","start":"2026-05-28T07:52:21.509467Z","end":"2026-05-28T07:52:21.678027Z","steps":["trace[623896440] 'process raft request' (duration: 168.209966ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T07:52:21.678128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.821943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-28T07:52:21.678192Z","caller":"traceutil/trace.go:171","msg":"trace[752602968] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:491; }","duration":"148.908065ms","start":"2026-05-28T07:52:21.529273Z","end":"2026-05-28T07:52:21.678181Z","steps":["trace[752602968] 'agreement among raft nodes before linearized reading' (duration: 148.765792ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T07:52:29.52864Z","caller":"traceutil/trace.go:171","msg":"trace[981177317] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"124.196898ms","start":"2026-05-28T07:52:29.404411Z","end":"2026-05-28T07:52:29.528608Z","steps":["trace[981177317] 'process raft request' (duration: 123.366343ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T07:52:30.095265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.181206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-28T07:52:30.095359Z","caller":"traceutil/trace.go:171","msg":"trace[25769969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:637; }","duration":"331.322059ms","start":"2026-05-28T07:52:29.764014Z","end":"2026-05-28T07:52:30.095336Z","steps":["trace[25769969] 'range keys from in-memory index tree' (duration: 331.018302ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T07:52:30.095404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T07:52:29.763995Z","time spent":"331.40024ms","remote":"127.0.0.1:51892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-28T07:53:18.545208Z","caller":"traceutil/trace.go:171","msg":"trace[1044270075] linearizableReadLoop","detail":"{readStateIndex:1239; appliedIndex:1238; }","duration":"217.7806ms","start":"2026-05-28T07:53:18.327401Z","end":"2026-05-28T07:53:18.545182Z","steps":["trace[1044270075] 'read index received' (duration: 217.560466ms)","trace[1044270075] 'applied index is now lower than readState.Index' (duration: 218.964µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T07:53:18.54529Z","caller":"traceutil/trace.go:171","msg":"trace[2087767080] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"226.428734ms","start":"2026-05-28T07:53:18.31883Z","end":"2026-05-28T07:53:18.545259Z","steps":["trace[2087767080] 'process raft request' (duration: 226.197129ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T07:53:18.545671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.218299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-28T07:53:18.545741Z","caller":"traceutil/trace.go:171","msg":"trace[1043801330] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1206; }","duration":"218.381701ms","start":"2026-05-28T07:53:18.32734Z","end":"2026-05-28T07:53:18.545722Z","steps":["trace[1043801330] 'agreement among raft nodes before linearized reading' (duration: 217.945393ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T07:54:06.692963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.023197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4534376f-487e-4aa1-a47b-7b93c10eb793\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-28T07:54:06.693061Z","caller":"traceutil/trace.go:171","msg":"trace[1793522764] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4534376f-487e-4aa1-a47b-7b93c10eb793; range_end:; response_count:1; response_revision:1886; }","duration":"162.192359ms","start":"2026-05-28T07:54:06.530846Z","end":"2026-05-28T07:54:06.693038Z","steps":["trace[1793522764] 'range keys from in-memory index tree' (duration: 161.820722ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T07:54:06.693152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.598968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T07:54:06.693278Z","caller":"traceutil/trace.go:171","msg":"trace[1826255563] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1886; }","duration":"264.001436ms","start":"2026-05-28T07:54:06.429227Z","end":"2026-05-28T07:54:06.693229Z","steps":["trace[1826255563] 'count revisions from in-memory index tree' (duration: 263.524517ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T07:54:07.155692Z","caller":"traceutil/trace.go:171","msg":"trace[1123565236] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"296.486971ms","start":"2026-05-28T07:54:06.859173Z","end":"2026-05-28T07:54:07.15566Z","steps":["trace[1123565236] 'process raft request' (duration: 285.985402ms)","trace[1123565236] 'compare' (duration: 10.246675ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T07:54:07.155738Z","caller":"traceutil/trace.go:171","msg":"trace[1362461533] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"296.509581ms","start":"2026-05-28T07:54:06.859196Z","end":"2026-05-28T07:54:07.155706Z","steps":["trace[1362461533] 'process raft request' (duration: 296.375659ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T07:54:07.15588Z","caller":"traceutil/trace.go:171","msg":"trace[291259665] linearizableReadLoop","detail":"{readStateIndex:1959; appliedIndex:1955; }","duration":"289.59738ms","start":"2026-05-28T07:54:06.866274Z","end":"2026-05-28T07:54:07.155872Z","steps":["trace[291259665] 'read index received' (duration: 14.385092ms)","trace[291259665] 'applied index is now lower than readState.Index' (duration: 275.211288ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T07:54:07.156031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.918373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T07:54:07.15606Z","caller":"traceutil/trace.go:171","msg":"trace[60606864] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1893; }","duration":"163.006025ms","start":"2026-05-28T07:54:06.993045Z","end":"2026-05-28T07:54:07.156051Z","steps":["trace[60606864] 'agreement among raft nodes before linearized reading' (duration: 162.936223ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T07:54:07.156092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.816484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-28T07:54:07.156156Z","caller":"traceutil/trace.go:171","msg":"trace[1383839932] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1893; }","duration":"289.931956ms","start":"2026-05-28T07:54:06.86621Z","end":"2026-05-28T07:54:07.156142Z","steps":["trace[1383839932] 'agreement among raft nodes before linearized reading' (duration: 289.763643ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T07:54:07.156184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.87066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-28T07:54:07.156297Z","caller":"traceutil/trace.go:171","msg":"trace[1495989028] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1893; }","duration":"128.014842ms","start":"2026-05-28T07:54:07.02826Z","end":"2026-05-28T07:54:07.156275Z","steps":["trace[1495989028] 'agreement among raft nodes before linearized reading' (duration: 127.738327ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T07:54:07.156294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.219164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-28T07:54:07.15635Z","caller":"traceutil/trace.go:171","msg":"trace[392100188] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"296.96001ms","start":"2026-05-28T07:54:06.859372Z","end":"2026-05-28T07:54:07.156332Z","steps":["trace[392100188] 'process raft request' (duration: 296.283617ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T07:54:07.156371Z","caller":"traceutil/trace.go:171","msg":"trace[730147498] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1893; }","duration":"130.339716ms","start":"2026-05-28T07:54:07.02601Z","end":"2026-05-28T07:54:07.15635Z","steps":["trace[730147498] 'agreement among raft nodes before linearized reading' (duration: 130.150763ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T07:54:07.156482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.372088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-28T07:54:07.156531Z","caller":"traceutil/trace.go:171","msg":"trace[746766389] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1893; }","duration":"129.46156ms","start":"2026-05-28T07:54:07.027058Z","end":"2026-05-28T07:54:07.156519Z","steps":["trace[746766389] 'agreement among raft nodes before linearized reading' (duration: 129.340468ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T07:54:56.236256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.6522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-28T07:54:56.236351Z","caller":"traceutil/trace.go:171","msg":"trace[1535106362] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2213; }","duration":"104.805023ms","start":"2026-05-28T07:54:56.131527Z","end":"2026-05-28T07:54:56.236332Z","steps":["trace[1535106362] 'range keys from in-memory index tree' (duration: 104.398765ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T07:55:02.250493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.721403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T07:55:02.250586Z","caller":"traceutil/trace.go:171","msg":"trace[1385790324] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:2244; }","duration":"103.898226ms","start":"2026-05-28T07:55:02.146667Z","end":"2026-05-28T07:55:02.250566Z","steps":["trace[1385790324] 'count revisions from in-memory index tree' (duration: 103.628451ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T07:55:02.381535Z","caller":"traceutil/trace.go:171","msg":"trace[1657345248] transaction","detail":"{read_only:false; response_revision:2245; number_of_response:1; }","duration":"100.346899ms","start":"2026-05-28T07:55:02.28116Z","end":"2026-05-28T07:55:02.381507Z","steps":["trace[1657345248] 'process raft request' (duration: 100.187096ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T07:56:10.113949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.415598ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-28T07:56:10.114082Z","caller":"traceutil/trace.go:171","msg":"trace[695560734] linearizableReadLoop","detail":"{readStateIndex:2908; appliedIndex:2906; }","duration":"360.138169ms","start":"2026-05-28T07:56:09.753913Z","end":"2026-05-28T07:56:10.114051Z","steps":["trace[695560734] 'read index received' (duration: 92.55406ms)","trace[695560734] 'applied index is now lower than readState.Index' (duration: 267.583279ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T07:56:10.114156Z","caller":"traceutil/trace.go:171","msg":"trace[1106504095] transaction","detail":"{read_only:false; response_revision:2807; number_of_response:1; }","duration":"360.697949ms","start":"2026-05-28T07:56:09.753451Z","end":"2026-05-28T07:56:10.114149Z","steps":["trace[1106504095] 'process raft request' (duration: 227.696ms)","trace[1106504095] 'compare' (duration: 132.342197ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T07:56:10.114192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T07:56:09.753431Z","time spent":"360.74335ms","remote":"127.0.0.1:51892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T07:56:10.114341Z","caller":"traceutil/trace.go:171","msg":"trace[1761845434] transaction","detail":"{read_only:false; response_revision:2808; number_of_response:1; }","duration":"359.251114ms","start":"2026-05-28T07:56:09.755068Z","end":"2026-05-28T07:56:10.114319Z","steps":["trace[1761845434] 'process raft request' (duration: 358.946647ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T07:56:10.11441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.495976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-28T07:56:10.114449Z","caller":"traceutil/trace.go:171","msg":"trace[2068555983] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2808; }","duration":"360.547968ms","start":"2026-05-28T07:56:09.753895Z","end":"2026-05-28T07:56:10.114443Z","steps":["trace[2068555983] 'agreement among raft nodes before linearized reading' (duration: 360.436416ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T07:56:10.114456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T07:56:09.755057Z","time spent":"359.340925ms","remote":"127.0.0.1:51892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T07:56:10.114471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T07:56:09.753887Z","time spent":"360.579288ms","remote":"127.0.0.1:51892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-28T07:56:10.140829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.701763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-28T07:56:10.140871Z","caller":"traceutil/trace.go:171","msg":"trace[2085457694] transaction","detail":"{read_only:false; response_revision:2809; number_of_response:1; }","duration":"242.673875ms","start":"2026-05-28T07:56:09.898162Z","end":"2026-05-28T07:56:10.140836Z","steps":["trace[2085457694] 'process raft request' (duration: 242.475872ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T07:56:10.140912Z","caller":"traceutil/trace.go:171","msg":"trace[80240855] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:2809; }","duration":"358.847916ms","start":"2026-05-28T07:56:09.782046Z","end":"2026-05-28T07:56:10.140894Z","steps":["trace[80240855] 'agreement among raft nodes before linearized reading' (duration: 358.707113ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T07:56:10.140941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.988012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-28T07:56:10.140988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T07:56:09.782022Z","time spent":"358.954857ms","remote":"127.0.0.1:52096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":4,"response size":30,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"info","ts":"2026-05-28T07:56:10.140994Z","caller":"traceutil/trace.go:171","msg":"trace[183941233] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2809; }","duration":"334.122864ms","start":"2026-05-28T07:56:09.806857Z","end":"2026-05-28T07:56:10.14098Z","steps":["trace[183941233] 'agreement among raft nodes before linearized reading' (duration: 334.002902ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T07:56:10.141038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T07:56:09.80684Z","time spent":"334.190096ms","remote":"127.0.0.1:51644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-28T08:00:45.193613Z","caller":"traceutil/trace.go:171","msg":"trace[936943951] transaction","detail":"{read_only:false; response_revision:5372; number_of_response:1; }","duration":"119.132304ms","start":"2026-05-28T08:00:45.074454Z","end":"2026-05-28T08:00:45.193587Z","steps":["trace[936943951] 'process raft request' (duration: 118.957251ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:00:45.302568Z","caller":"traceutil/trace.go:171","msg":"trace[928003604] transaction","detail":"{read_only:false; response_revision:5373; number_of_response:1; }","duration":"197.302083ms","start":"2026-05-28T08:00:45.105237Z","end":"2026-05-28T08:00:45.302539Z","steps":["trace[928003604] 'process raft request' (duration: 157.279026ms)","trace[928003604] 'compare' (duration: 39.868324ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T08:00:45.320322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.303447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T08:00:45.320385Z","caller":"traceutil/trace.go:171","msg":"trace[558917330] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:5374; }","duration":"102.424888ms","start":"2026-05-28T08:00:45.217948Z","end":"2026-05-28T08:00:45.320373Z","steps":["trace[558917330] 'agreement among raft nodes before linearized reading' (duration: 102.277315ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T08:00:45.814306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.728358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ccf14eaa-b595-4dbe-9e29-1069aa386219\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-05-28T08:00:45.814383Z","caller":"traceutil/trace.go:171","msg":"trace[119750039] transaction","detail":"{read_only:false; response_revision:5385; number_of_response:1; }","duration":"271.212572ms","start":"2026-05-28T08:00:45.54315Z","end":"2026-05-28T08:00:45.814363Z","steps":["trace[119750039] 'process raft request' (duration: 255.403593ms)","trace[119750039] 'compare' (duration: 15.566945ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T08:00:45.814409Z","caller":"traceutil/trace.go:171","msg":"trace[1236061656] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ccf14eaa-b595-4dbe-9e29-1069aa386219; range_end:; response_count:1; response_revision:5384; }","duration":"275.871221ms","start":"2026-05-28T08:00:45.538513Z","end":"2026-05-28T08:00:45.814384Z","steps":["trace[1236061656] 'range keys from in-memory index tree' (duration: 275.585655ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:00:46.053785Z","caller":"traceutil/trace.go:171","msg":"trace[503397809] linearizableReadLoop","detail":"{readStateIndex:5582; appliedIndex:5581; }","duration":"248.94566ms","start":"2026-05-28T08:00:45.804802Z","end":"2026-05-28T08:00:46.053748Z","steps":["trace[503397809] 'read index received' (duration: 195.04632ms)","trace[503397809] 'applied index is now lower than readState.Index' (duration: 53.89795ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T08:00:46.053858Z","caller":"traceutil/trace.go:171","msg":"trace[77460438] transaction","detail":"{read_only:false; response_revision:5386; number_of_response:1; }","duration":"370.814448ms","start":"2026-05-28T08:00:45.683009Z","end":"2026-05-28T08:00:46.053823Z","steps":["trace[77460438] 'process raft request' (duration: 316.851237ms)","trace[77460438] 'compare' (duration: 53.763137ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T08:00:46.054016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.207896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-ppzmg\" ","response":"range_response_count:1 size:6445"} {"level":"info","ts":"2026-05-28T08:00:46.054075Z","caller":"traceutil/trace.go:171","msg":"trace[752388088] range","detail":"{range_begin:/registry/pods/openstack/keepalived-ppzmg; range_end:; response_count:1; response_revision:5386; }","duration":"249.313778ms","start":"2026-05-28T08:00:45.804748Z","end":"2026-05-28T08:00:46.054062Z","steps":["trace[752388088] 'agreement among raft nodes before linearized reading' (duration: 249.113183ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T08:00:46.054131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T08:00:45.682979Z","time spent":"370.96026ms","remote":"127.0.0.1:51892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T08:00:46.061321Z","caller":"traceutil/trace.go:171","msg":"trace[1298350218] transaction","detail":"{read_only:false; response_revision:5387; number_of_response:1; }","duration":"240.638484ms","start":"2026-05-28T08:00:45.820649Z","end":"2026-05-28T08:00:46.061287Z","steps":["trace[1298350218] 'process raft request' (duration: 240.478541ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T08:00:46.061823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.365908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-05-28T08:00:46.061908Z","caller":"traceutil/trace.go:171","msg":"trace[519804976] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5387; }","duration":"110.660763ms","start":"2026-05-28T08:00:45.951227Z","end":"2026-05-28T08:00:46.061888Z","steps":["trace[519804976] 'agreement among raft nodes before linearized reading' (duration: 110.235745ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:01:05.514386Z","caller":"traceutil/trace.go:171","msg":"trace[1247536700] transaction","detail":"{read_only:false; response_revision:5601; number_of_response:1; }","duration":"116.094127ms","start":"2026-05-28T08:01:05.398209Z","end":"2026-05-28T08:01:05.514303Z","steps":["trace[1247536700] 'process raft request' (duration: 67.851204ms)","trace[1247536700] 'compare' (duration: 47.680602ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T08:01:15.408367Z","caller":"traceutil/trace.go:171","msg":"trace[648514195] transaction","detail":"{read_only:false; response_revision:5726; number_of_response:1; }","duration":"118.218887ms","start":"2026-05-28T08:01:15.290116Z","end":"2026-05-28T08:01:15.408335Z","steps":["trace[648514195] 'process raft request' (duration: 117.985332ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T08:01:15.900038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.473228ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-28T08:01:15.900154Z","caller":"traceutil/trace.go:171","msg":"trace[2146377659] transaction","detail":"{read_only:false; response_revision:5727; number_of_response:1; }","duration":"494.399133ms","start":"2026-05-28T08:01:15.405738Z","end":"2026-05-28T08:01:15.900137Z","steps":["trace[2146377659] 'process raft request' (duration: 160.761982ms)","trace[2146377659] 'compare' (duration: 333.332935ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T08:01:15.900207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T08:01:15.405718Z","time spent":"494.464014ms","remote":"127.0.0.1:51892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T08:01:15.900751Z","caller":"traceutil/trace.go:171","msg":"trace[1806654716] transaction","detail":"{read_only:false; response_revision:5728; number_of_response:1; }","duration":"484.879312ms","start":"2026-05-28T08:01:15.415832Z","end":"2026-05-28T08:01:15.900711Z","steps":["trace[1806654716] 'process raft request' (duration: 484.665158ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:01:15.900874Z","caller":"traceutil/trace.go:171","msg":"trace[2116816376] transaction","detail":"{read_only:false; response_revision:5729; number_of_response:1; }","duration":"484.813051ms","start":"2026-05-28T08:01:15.416049Z","end":"2026-05-28T08:01:15.900862Z","steps":["trace[2116816376] 'process raft request' (duration: 484.610867ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:01:15.900894Z","caller":"traceutil/trace.go:171","msg":"trace[1595894557] linearizableReadLoop","detail":"{readStateIndex:5933; appliedIndex:5931; }","duration":"304.310757ms","start":"2026-05-28T08:01:15.596547Z","end":"2026-05-28T08:01:15.900858Z","steps":["trace[1595894557] 'read index received' (duration: 303.855819ms)","trace[1595894557] 'applied index is now lower than readState.Index' (duration: 453.298µs)"],"step_count":2} {"level":"warn","ts":"2026-05-28T08:01:15.900968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T08:01:15.41604Z","time spent":"484.863312ms","remote":"127.0.0.1:51892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T08:01:15.901052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T08:01:15.415811Z","time spent":"485.065386ms","remote":"127.0.0.1:51818","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8152,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T08:01:15.901168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.987073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T08:01:15.901246Z","caller":"traceutil/trace.go:171","msg":"trace[2034550251] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:5729; }","duration":"283.108695ms","start":"2026-05-28T08:01:15.618119Z","end":"2026-05-28T08:01:15.901228Z","steps":["trace[2034550251] 'agreement among raft nodes before linearized reading' (duration: 282.945842ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T08:01:15.901215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.651764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-05-28T08:01:15.901292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.494597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-28T08:01:15.901329Z","caller":"traceutil/trace.go:171","msg":"trace[1050928653] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5729; }","duration":"279.567979ms","start":"2026-05-28T08:01:15.621753Z","end":"2026-05-28T08:01:15.901321Z","steps":["trace[1050928653] 'agreement among raft nodes before linearized reading' (duration: 279.451017ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:01:15.901316Z","caller":"traceutil/trace.go:171","msg":"trace[277535956] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5729; }","duration":"304.761956ms","start":"2026-05-28T08:01:15.596532Z","end":"2026-05-28T08:01:15.901294Z","steps":["trace[277535956] 'agreement among raft nodes before linearized reading' (duration: 304.48425ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T08:01:15.901241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.159041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-05-28T08:01:15.901383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T08:01:15.596475Z","time spent":"304.889858ms","remote":"127.0.0.1:51892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-28T08:01:15.901464Z","caller":"traceutil/trace.go:171","msg":"trace[1326046900] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5729; }","duration":"269.388496ms","start":"2026-05-28T08:01:15.632039Z","end":"2026-05-28T08:01:15.901428Z","steps":["trace[1326046900] 'agreement among raft nodes before linearized reading' (duration: 269.03842ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T08:01:15.901691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.380083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-28T08:01:15.901771Z","caller":"traceutil/trace.go:171","msg":"trace[64259150] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5729; }","duration":"272.487424ms","start":"2026-05-28T08:01:15.629264Z","end":"2026-05-28T08:01:15.901752Z","steps":["trace[64259150] 'agreement among raft nodes before linearized reading' (duration: 271.816732ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:01:16.117531Z","caller":"traceutil/trace.go:171","msg":"trace[162661299] transaction","detail":"{read_only:false; response_revision:5730; number_of_response:1; }","duration":"213.01081ms","start":"2026-05-28T08:01:15.904467Z","end":"2026-05-28T08:01:16.117478Z","steps":["trace[162661299] 'process raft request' (duration: 135.649347ms)","trace[162661299] 'compare' (duration: 77.161059ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T08:01:16.166553Z","caller":"traceutil/trace.go:171","msg":"trace[1673334557] transaction","detail":"{read_only:false; response_revision:5732; number_of_response:1; }","duration":"260.730382ms","start":"2026-05-28T08:01:15.90578Z","end":"2026-05-28T08:01:16.16651Z","steps":["trace[1673334557] 'process raft request' (duration: 260.580169ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:01:16.1666Z","caller":"traceutil/trace.go:171","msg":"trace[852065536] transaction","detail":"{read_only:false; response_revision:5731; number_of_response:1; }","duration":"261.713341ms","start":"2026-05-28T08:01:15.904822Z","end":"2026-05-28T08:01:16.166535Z","steps":["trace[852065536] 'process raft request' (duration: 261.213972ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:01:16.166924Z","caller":"traceutil/trace.go:171","msg":"trace[1744767775] transaction","detail":"{read_only:false; response_revision:5733; number_of_response:1; }","duration":"260.983307ms","start":"2026-05-28T08:01:15.905877Z","end":"2026-05-28T08:01:16.16686Z","steps":["trace[1744767775] 'process raft request' (duration: 260.548329ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:01:16.16718Z","caller":"traceutil/trace.go:171","msg":"trace[1439358685] transaction","detail":"{read_only:false; response_revision:5734; number_of_response:1; }","duration":"261.268652ms","start":"2026-05-28T08:01:15.905888Z","end":"2026-05-28T08:01:16.167156Z","steps":["trace[1439358685] 'process raft request' (duration: 260.841164ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:01:16.167335Z","caller":"traceutil/trace.go:171","msg":"trace[1100513256] transaction","detail":"{read_only:false; response_revision:5735; number_of_response:1; }","duration":"261.130449ms","start":"2026-05-28T08:01:15.906181Z","end":"2026-05-28T08:01:16.167312Z","steps":["trace[1100513256] 'process raft request' (duration: 260.809354ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:01:16.167392Z","caller":"traceutil/trace.go:171","msg":"trace[645618846] transaction","detail":"{read_only:false; response_revision:5736; number_of_response:1; }","duration":"261.211521ms","start":"2026-05-28T08:01:15.906164Z","end":"2026-05-28T08:01:16.167376Z","steps":["trace[645618846] 'process raft request' (duration: 261.031937ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:01:16.167662Z","caller":"traceutil/trace.go:171","msg":"trace[1500102832] transaction","detail":"{read_only:false; response_revision:5737; number_of_response:1; }","duration":"261.12358ms","start":"2026-05-28T08:01:15.906519Z","end":"2026-05-28T08:01:16.167643Z","steps":["trace[1500102832] 'process raft request' (duration: 260.806434ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:01:16.167694Z","caller":"traceutil/trace.go:171","msg":"trace[1074622130] linearizableReadLoop","detail":"{readStateIndex:5935; appliedIndex:5933; }","duration":"262.473855ms","start":"2026-05-28T08:01:15.905197Z","end":"2026-05-28T08:01:16.167671Z","steps":["trace[1074622130] 'read index received' (duration: 134.987494ms)","trace[1074622130] 'applied index is now lower than readState.Index' (duration: 127.484791ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T08:01:16.167768Z","caller":"traceutil/trace.go:171","msg":"trace[2044364358] transaction","detail":"{read_only:false; response_revision:5738; number_of_response:1; }","duration":"260.412306ms","start":"2026-05-28T08:01:15.907323Z","end":"2026-05-28T08:01:16.167736Z","steps":["trace[2044364358] 'process raft request' (duration: 260.237883ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T08:01:16.167936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.705979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-ccf14eaa-b595-4dbe-9e29-1069aa386219\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-05-28T08:01:16.167998Z","caller":"traceutil/trace.go:171","msg":"trace[1551219530] range","detail":"{range_begin:/registry/persistentvolumes/pvc-ccf14eaa-b595-4dbe-9e29-1069aa386219; range_end:; response_count:1; response_revision:5738; }","duration":"262.786921ms","start":"2026-05-28T08:01:15.90519Z","end":"2026-05-28T08:01:16.167977Z","steps":["trace[1551219530] 'agreement among raft nodes before linearized reading' (duration: 262.564267ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:01:16.185776Z","caller":"traceutil/trace.go:171","msg":"trace[1940069848] transaction","detail":"{read_only:false; response_revision:5739; number_of_response:1; }","duration":"106.546966ms","start":"2026-05-28T08:01:16.079194Z","end":"2026-05-28T08:01:16.185741Z","steps":["trace[1940069848] 'process raft request' (duration: 106.385503ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:01:45.005339Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3000} {"level":"info","ts":"2026-05-28T08:01:45.075872Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3000,"took":"69.339591ms","hash":133741691,"current-db-size-bytes":56381440,"current-db-size":"56 MB","current-db-size-in-use-bytes":32960512,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-05-28T08:01:45.075964Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":133741691,"revision":3000,"compact-revision":-1} {"level":"info","ts":"2026-05-28T08:06:45.012068Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5933} {"level":"info","ts":"2026-05-28T08:06:45.091753Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5933,"took":"77.686781ms","hash":606309393,"current-db-size-bytes":56381440,"current-db-size":"56 MB","current-db-size-in-use-bytes":25882624,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-05-28T08:06:45.091806Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":606309393,"revision":5933,"compact-revision":3000} {"level":"info","ts":"2026-05-28T08:07:35.511702Z","caller":"traceutil/trace.go:171","msg":"trace[554270230] transaction","detail":"{read_only:false; response_revision:8552; number_of_response:1; }","duration":"227.851014ms","start":"2026-05-28T08:07:35.283712Z","end":"2026-05-28T08:07:35.511563Z","steps":["trace[554270230] 'process raft request' (duration: 227.6351ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:07:35.58647Z","caller":"traceutil/trace.go:171","msg":"trace[148370974] transaction","detail":"{read_only:false; response_revision:8553; number_of_response:1; }","duration":"291.367378ms","start":"2026-05-28T08:07:35.29506Z","end":"2026-05-28T08:07:35.586427Z","steps":["trace[148370974] 'process raft request' (duration: 291.118593ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:08:05.059849Z","caller":"traceutil/trace.go:171","msg":"trace[1806025072] transaction","detail":"{read_only:false; response_revision:8768; number_of_response:1; }","duration":"147.751428ms","start":"2026-05-28T08:08:04.912077Z","end":"2026-05-28T08:08:05.059828Z","steps":["trace[1806025072] 'process raft request' (duration: 147.110496ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:08:19.208874Z","caller":"traceutil/trace.go:171","msg":"trace[1597253810] transaction","detail":"{read_only:false; response_revision:8885; number_of_response:1; }","duration":"105.203442ms","start":"2026-05-28T08:08:19.103648Z","end":"2026-05-28T08:08:19.208852Z","steps":["trace[1597253810] 'process raft request' (duration: 105.014239ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:08:20.286475Z","caller":"traceutil/trace.go:171","msg":"trace[366181477] linearizableReadLoop","detail":"{readStateIndex:9202; appliedIndex:9201; }","duration":"113.279564ms","start":"2026-05-28T08:08:20.173173Z","end":"2026-05-28T08:08:20.286453Z","steps":["trace[366181477] 'read index received' (duration: 84.910777ms)","trace[366181477] 'applied index is now lower than readState.Index' (duration: 28.367637ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T08:08:20.286573Z","caller":"traceutil/trace.go:171","msg":"trace[1086709006] transaction","detail":"{read_only:false; response_revision:8891; number_of_response:1; }","duration":"225.691675ms","start":"2026-05-28T08:08:20.060835Z","end":"2026-05-28T08:08:20.286527Z","steps":["trace[1086709006] 'process raft request' (duration: 197.283596ms)","trace[1086709006] 'compare' (duration: 27.99696ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T08:08:20.286679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.49606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-28T08:08:20.286725Z","caller":"traceutil/trace.go:171","msg":"trace[283923724] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:8891; }","duration":"113.599361ms","start":"2026-05-28T08:08:20.173114Z","end":"2026-05-28T08:08:20.286713Z","steps":["trace[283923724] 'agreement among raft nodes before linearized reading' (duration: 113.472269ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:08:20.770317Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023fc.wal"} {"level":"info","ts":"2026-05-28T08:09:38.109923Z","caller":"traceutil/trace.go:171","msg":"trace[879868023] transaction","detail":"{read_only:false; response_revision:9649; number_of_response:1; }","duration":"130.752976ms","start":"2026-05-28T08:09:37.979142Z","end":"2026-05-28T08:09:38.109895Z","steps":["trace[879868023] 'process raft request' (duration: 130.595613ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:09:38.109956Z","caller":"traceutil/trace.go:171","msg":"trace[739605160] linearizableReadLoop","detail":"{readStateIndex:9979; appliedIndex:9979; }","duration":"115.501177ms","start":"2026-05-28T08:09:37.994428Z","end":"2026-05-28T08:09:38.10993Z","steps":["trace[739605160] 'read index received' (duration: 115.488487ms)","trace[739605160] 'applied index is now lower than readState.Index' (duration: 10.37µs)"],"step_count":2} {"level":"warn","ts":"2026-05-28T08:09:38.11012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.6743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-28T08:09:38.110207Z","caller":"traceutil/trace.go:171","msg":"trace[609280102] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:9649; }","duration":"115.810302ms","start":"2026-05-28T08:09:37.994373Z","end":"2026-05-28T08:09:38.110183Z","steps":["trace[609280102] 'agreement among raft nodes before linearized reading' (duration: 115.66793ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T08:09:38.123669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.162821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.222\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-28T08:09:38.123727Z","caller":"traceutil/trace.go:171","msg":"trace[660205803] range","detail":"{range_begin:/registry/masterleases/199.204.45.222; range_end:; response_count:1; response_revision:9650; }","duration":"115.260343ms","start":"2026-05-28T08:09:38.008452Z","end":"2026-05-28T08:09:38.123712Z","steps":["trace[660205803] 'agreement among raft nodes before linearized reading' (duration: 115.09197ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:09:40.892153Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"380f6760faea5f9e","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-28T08:09:40.898425Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-05-28T08:09:40.898542Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-05-28T08:11:45.020901Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8111} {"level":"info","ts":"2026-05-28T08:11:45.081781Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8111,"took":"58.5443ms","hash":3499540873,"current-db-size-bytes":56381440,"current-db-size":"56 MB","current-db-size-in-use-bytes":28319744,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-05-28T08:11:45.081856Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3499540873,"revision":8111,"compact-revision":5933} {"level":"info","ts":"2026-05-28T08:14:56.697892Z","caller":"traceutil/trace.go:171","msg":"trace[473167400] transaction","detail":"{read_only:false; response_revision:11971; number_of_response:1; }","duration":"188.913689ms","start":"2026-05-28T08:14:56.508957Z","end":"2026-05-28T08:14:56.69787Z","steps":["trace[473167400] 'process raft request' (duration: 188.867148ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:14:56.698356Z","caller":"traceutil/trace.go:171","msg":"trace[923419680] transaction","detail":"{read_only:false; response_revision:11969; number_of_response:1; }","duration":"191.795363ms","start":"2026-05-28T08:14:56.506549Z","end":"2026-05-28T08:14:56.698344Z","steps":["trace[923419680] 'process raft request' (duration: 191.09225ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:14:56.698498Z","caller":"traceutil/trace.go:171","msg":"trace[1141350953] transaction","detail":"{read_only:false; response_revision:11970; number_of_response:1; }","duration":"190.615961ms","start":"2026-05-28T08:14:56.507872Z","end":"2026-05-28T08:14:56.698488Z","steps":["trace[1141350953] 'process raft request' (duration: 189.913968ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:16:45.027246Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10522} {"level":"info","ts":"2026-05-28T08:16:45.109009Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10522,"took":"79.113154ms","hash":1289214784,"current-db-size-bytes":56381440,"current-db-size":"56 MB","current-db-size-in-use-bytes":26157056,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-05-28T08:16:45.109058Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1289214784,"revision":10522,"compact-revision":8111} {"level":"info","ts":"2026-05-28T08:21:45.035011Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12651} {"level":"info","ts":"2026-05-28T08:21:45.10784Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12651,"took":"70.03057ms","hash":3113867775,"current-db-size-bytes":56381440,"current-db-size":"56 MB","current-db-size-in-use-bytes":27578368,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-05-28T08:21:45.107992Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3113867775,"revision":12651,"compact-revision":10522} {"level":"info","ts":"2026-05-28T08:22:01.175384Z","caller":"traceutil/trace.go:171","msg":"trace[332272642] transaction","detail":"{read_only:false; response_revision:14775; number_of_response:1; }","duration":"284.444792ms","start":"2026-05-28T08:22:00.890913Z","end":"2026-05-28T08:22:01.175357Z","steps":["trace[332272642] 'process raft request' (duration: 284.218037ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:22:01.175586Z","caller":"traceutil/trace.go:171","msg":"trace[56766931] linearizableReadLoop","detail":"{readStateIndex:15281; appliedIndex:15279; }","duration":"213.465704ms","start":"2026-05-28T08:22:00.962081Z","end":"2026-05-28T08:22:01.175547Z","steps":["trace[56766931] 'read index received' (duration: 213.108367ms)","trace[56766931] 'applied index is now lower than readState.Index' (duration: 354.817µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T08:22:01.175814Z","caller":"traceutil/trace.go:171","msg":"trace[352777189] transaction","detail":"{read_only:false; response_revision:14776; number_of_response:1; }","duration":"282.734379ms","start":"2026-05-28T08:22:00.893049Z","end":"2026-05-28T08:22:01.175784Z","steps":["trace[352777189] 'process raft request' (duration: 282.25311ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T08:22:01.17609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.982084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-28T08:22:01.176162Z","caller":"traceutil/trace.go:171","msg":"trace[1039879784] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14776; }","duration":"214.106857ms","start":"2026-05-28T08:22:00.962034Z","end":"2026-05-28T08:22:01.176141Z","steps":["trace[1039879784] 'agreement among raft nodes before linearized reading' (duration: 213.900613ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:22:01.357461Z","caller":"traceutil/trace.go:171","msg":"trace[785771612] transaction","detail":"{read_only:false; response_revision:14777; number_of_response:1; }","duration":"213.372823ms","start":"2026-05-28T08:22:01.144036Z","end":"2026-05-28T08:22:01.357409Z","steps":["trace[785771612] 'process raft request' (duration: 163.449445ms)","trace[785771612] 'compare' (duration: 49.669902ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T08:22:01.357486Z","caller":"traceutil/trace.go:171","msg":"trace[557080562] transaction","detail":"{read_only:false; response_revision:14778; number_of_response:1; }","duration":"176.551573ms","start":"2026-05-28T08:22:01.180904Z","end":"2026-05-28T08:22:01.357456Z","steps":["trace[557080562] 'process raft request' (duration: 176.476851ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:22:01.35753Z","caller":"traceutil/trace.go:171","msg":"trace[1684467944] linearizableReadLoop","detail":"{readStateIndex:15282; appliedIndex:15281; }","duration":"181.812932ms","start":"2026-05-28T08:22:01.175685Z","end":"2026-05-28T08:22:01.357498Z","steps":["trace[1684467944] 'read index received' (duration: 131.817183ms)","trace[1684467944] 'applied index is now lower than readState.Index' (duration: 49.992489ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T08:22:01.357814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.786461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-05-28T08:22:01.357819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.025161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-ppzmg\" ","response":"range_response_count:1 size:6445"} {"level":"info","ts":"2026-05-28T08:22:01.357879Z","caller":"traceutil/trace.go:171","msg":"trace[1052770862] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14778; }","duration":"390.896373ms","start":"2026-05-28T08:22:00.966966Z","end":"2026-05-28T08:22:01.357862Z","steps":["trace[1052770862] 'agreement among raft nodes before linearized reading' (duration: 390.675619ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:22:01.357889Z","caller":"traceutil/trace.go:171","msg":"trace[1487791155] range","detail":"{range_begin:/registry/pods/openstack/keepalived-ppzmg; range_end:; response_count:1; response_revision:14778; }","duration":"178.132222ms","start":"2026-05-28T08:22:01.179739Z","end":"2026-05-28T08:22:01.357871Z","steps":["trace[1487791155] 'agreement among raft nodes before linearized reading' (duration: 177.946419ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T08:22:01.357927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T08:22:00.96695Z","time spent":"390.963344ms","remote":"127.0.0.1:51892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-28T08:22:01.357817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.620579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-28T08:22:01.358009Z","caller":"traceutil/trace.go:171","msg":"trace[1427337077] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:14778; }","duration":"230.880755ms","start":"2026-05-28T08:22:01.127108Z","end":"2026-05-28T08:22:01.357988Z","steps":["trace[1427337077] 'agreement among raft nodes before linearized reading' (duration: 230.567909ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T08:22:01.358326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.116619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T08:22:01.358421Z","caller":"traceutil/trace.go:171","msg":"trace[1524033830] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:14778; }","duration":"379.300663ms","start":"2026-05-28T08:22:00.979097Z","end":"2026-05-28T08:22:01.358397Z","steps":["trace[1524033830] 'agreement among raft nodes before linearized reading' (duration: 378.506848ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T08:22:01.358467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T08:22:00.979081Z","time spent":"379.374644ms","remote":"127.0.0.1:49972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true "} {"level":"info","ts":"2026-05-28T08:22:12.413637Z","caller":"traceutil/trace.go:171","msg":"trace[1888324629] transaction","detail":"{read_only:false; response_revision:14951; number_of_response:1; }","duration":"104.613586ms","start":"2026-05-28T08:22:12.308994Z","end":"2026-05-28T08:22:12.413608Z","steps":["trace[1888324629] 'process raft request' (duration: 104.453243ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:22:12.518452Z","caller":"traceutil/trace.go:171","msg":"trace[578090586] transaction","detail":"{read_only:false; response_revision:14952; number_of_response:1; }","duration":"144.222519ms","start":"2026-05-28T08:22:12.374207Z","end":"2026-05-28T08:22:12.51843Z","steps":["trace[578090586] 'process raft request' (duration: 144.066437ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:22:12.736677Z","caller":"traceutil/trace.go:171","msg":"trace[631121977] linearizableReadLoop","detail":"{readStateIndex:15462; appliedIndex:15461; }","duration":"172.243271ms","start":"2026-05-28T08:22:12.564416Z","end":"2026-05-28T08:22:12.736659Z","steps":["trace[631121977] 'read index received' (duration: 92.976565ms)","trace[631121977] 'applied index is now lower than readState.Index' (duration: 79.266226ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T08:22:12.736767Z","caller":"traceutil/trace.go:171","msg":"trace[2061214322] transaction","detail":"{read_only:false; response_revision:14953; number_of_response:1; }","duration":"191.212551ms","start":"2026-05-28T08:22:12.545548Z","end":"2026-05-28T08:22:12.736761Z","steps":["trace[2061214322] 'process raft request' (duration: 111.895074ms)","trace[2061214322] 'compare' (duration: 79.143724ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T08:22:12.737007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.560857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-05-28T08:22:12.737073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.562411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:17 size:157469"} {"level":"info","ts":"2026-05-28T08:22:12.737146Z","caller":"traceutil/trace.go:171","msg":"trace[1918497424] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:17; response_revision:14953; }","duration":"139.671752ms","start":"2026-05-28T08:22:12.597459Z","end":"2026-05-28T08:22:12.737131Z","steps":["trace[1918497424] 'agreement among raft nodes before linearized reading' (duration: 139.317026ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:22:12.737093Z","caller":"traceutil/trace.go:171","msg":"trace[887447577] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14953; }","duration":"172.696089ms","start":"2026-05-28T08:22:12.564379Z","end":"2026-05-28T08:22:12.737075Z","steps":["trace[887447577] 'agreement among raft nodes before linearized reading' (duration: 172.452465ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:23:55.044414Z","caller":"traceutil/trace.go:171","msg":"trace[1624966461] linearizableReadLoop","detail":"{readStateIndex:16592; appliedIndex:16591; }","duration":"144.210058ms","start":"2026-05-28T08:23:54.900182Z","end":"2026-05-28T08:23:55.044392Z","steps":["trace[1624966461] 'read index received' (duration: 144.046015ms)","trace[1624966461] 'applied index is now lower than readState.Index' (duration: 162.813µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T08:23:55.044837Z","caller":"traceutil/trace.go:171","msg":"trace[923925352] transaction","detail":"{read_only:false; response_revision:16048; number_of_response:1; }","duration":"151.597638ms","start":"2026-05-28T08:23:54.893225Z","end":"2026-05-28T08:23:55.044823Z","steps":["trace[923925352] 'process raft request' (duration: 151.029038ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T08:23:55.045092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.889812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-28T08:23:55.045128Z","caller":"traceutil/trace.go:171","msg":"trace[207697900] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:16048; }","duration":"144.989474ms","start":"2026-05-28T08:23:54.900128Z","end":"2026-05-28T08:23:55.045118Z","steps":["trace[207697900] 'agreement among raft nodes before linearized reading' (duration: 144.903191ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T08:26:45.042738Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14679} {"level":"info","ts":"2026-05-28T08:26:45.120529Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14679,"took":"73.732813ms","hash":1125755494,"current-db-size-bytes":56381440,"current-db-size":"56 MB","current-db-size-in-use-bytes":31670272,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-28T08:26:45.120609Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1125755494,"revision":14679,"compact-revision":12651}