{"level":"warn","ts":"2026-10-15T06:26:00.136843Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T06:26:00.136975Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.78: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.78:2380","--initial-cluster=instance=https://199.204.45.78:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.78:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.78: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-10-15T06:26:00.137089Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T06:26:00.13711Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-10-15T06:26:00.137139Z","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-10-15T06:26:00.138124Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"]} {"level":"info","ts":"2026-10-15T06:26:00.138226Z","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.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.78: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-10-15T06:26:00.146048Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.511339ms"} {"level":"info","ts":"2026-10-15T06:26:00.156452Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6eb8766b1ec86e92","cluster-id":"9bbfe9e5d45d3718"} {"level":"info","ts":"2026-10-15T06:26:00.156564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=()"} {"level":"info","ts":"2026-10-15T06:26:00.1566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 0"} {"level":"info","ts":"2026-10-15T06:26:00.156622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6eb8766b1ec86e92 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-15T06:26:00.156633Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 1"} {"level":"info","ts":"2026-10-15T06:26:00.156694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"warn","ts":"2026-10-15T06:26:00.176Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-15T06:26:00.177508Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-15T06:26:00.180149Z","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-10-15T06:26:00.182167Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6eb8766b1ec86e92","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-15T06:26:00.182312Z","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-10-15T06:26:00.182393Z","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-10-15T06:26:00.182405Z","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-10-15T06:26:00.18356Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6eb8766b1ec86e92","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-15T06:26:00.183989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"info","ts":"2026-10-15T06:26:00.186902Z","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-10-15T06:26:00.187358Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6eb8766b1ec86e92","initial-advertise-peer-urls":["https://199.204.45.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-15T06:26:00.187439Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-15T06:26:00.187598Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-10-15T06:26:00.187677Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-10-15T06:26:00.186435Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","added-peer-id":"6eb8766b1ec86e92","added-peer-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-10-15T06:26:00.257895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 is starting a new election at term 1"} {"level":"info","ts":"2026-10-15T06:26:00.257962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-15T06:26:00.257999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgPreVoteResp from 6eb8766b1ec86e92 at term 1"} {"level":"info","ts":"2026-10-15T06:26:00.258019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became candidate at term 2"} {"level":"info","ts":"2026-10-15T06:26:00.258033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgVoteResp from 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-10-15T06:26:00.258048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became leader at term 2"} {"level":"info","ts":"2026-10-15T06:26:00.258061Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6eb8766b1ec86e92 elected leader 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-10-15T06:26:00.258863Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T06:26:00.260199Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T06:26:00.262294Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.78:2379"} {"level":"info","ts":"2026-10-15T06:26:00.262593Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T06:26:00.264177Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-15T06:26:00.26423Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-15T06:26:00.264402Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T06:26:00.264803Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-15T06:26:00.265211Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T06:26:00.265244Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T06:26:00.272218Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6eb8766b1ec86e92","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.78:2379]}","request-path":"/0/members/6eb8766b1ec86e92/attributes","cluster-id":"9bbfe9e5d45d3718","publish-timeout":"7s"} {"level":"info","ts":"2026-10-15T06:26:44.330981Z","caller":"traceutil/trace.go:171","msg":"trace[453094977] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"113.09073ms","start":"2026-10-15T06:26:44.217863Z","end":"2026-10-15T06:26:44.330954Z","steps":["trace[453094977] 'process raft request' (duration: 66.159782ms)","trace[453094977] 'compare' (duration: 46.727654ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:26:46.697817Z","caller":"traceutil/trace.go:171","msg":"trace[1982261635] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"137.376749ms","start":"2026-10-15T06:26:46.560384Z","end":"2026-10-15T06:26:46.69776Z","steps":["trace[1982261635] 'process raft request' (duration: 137.163675ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:26:51.189016Z","caller":"traceutil/trace.go:171","msg":"trace[1109386730] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:631; }","duration":"311.844982ms","start":"2026-10-15T06:26:50.877137Z","end":"2026-10-15T06:26:51.188982Z","steps":["trace[1109386730] 'read index received' (duration: 311.023146ms)","trace[1109386730] 'applied index is now lower than readState.Index' (duration: 820.846µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:26:51.189111Z","caller":"traceutil/trace.go:171","msg":"trace[1920445730] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"357.08165ms","start":"2026-10-15T06:26:50.832011Z","end":"2026-10-15T06:26:51.189093Z","steps":["trace[1920445730] 'process raft request' (duration: 356.427278ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:26:51.189366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.888466ms","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-10-15T06:26:51.189442Z","caller":"traceutil/trace.go:171","msg":"trace[1308419776] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:607; }","duration":"302.04554ms","start":"2026-10-15T06:26:50.88738Z","end":"2026-10-15T06:26:51.189425Z","steps":["trace[1308419776] 'agreement among raft nodes before linearized reading' (duration: 301.813095ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:26:51.189502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:26:50.887363Z","time spent":"302.126311ms","remote":"127.0.0.1:44350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-15T06:26:51.189528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.372642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-p8gsr\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-10-15T06:26:51.189785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:26:50.831992Z","time spent":"357.167162ms","remote":"127.0.0.1:44172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T06:26:51.189806Z","caller":"traceutil/trace.go:171","msg":"trace[592222561] range","detail":"{range_begin:/registry/pods/kube-system/cilium-p8gsr; range_end:; response_count:1; response_revision:607; }","duration":"312.711029ms","start":"2026-10-15T06:26:50.877075Z","end":"2026-10-15T06:26:51.189786Z","steps":["trace[592222561] 'agreement among raft nodes before linearized reading' (duration: 312.089707ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:26:51.190191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:26:50.877058Z","time spent":"312.994826ms","remote":"127.0.0.1:44252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-p8gsr\" "} {"level":"info","ts":"2026-10-15T06:26:51.605686Z","caller":"traceutil/trace.go:171","msg":"trace[715392862] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"399.752646ms","start":"2026-10-15T06:26:51.205907Z","end":"2026-10-15T06:26:51.605659Z","steps":["trace[715392862] 'process raft request' (duration: 399.602803ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:26:51.60584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:26:51.205885Z","time spent":"399.879429ms","remote":"127.0.0.1:44252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T06:26:51.919757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.57149ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-15T06:26:51.919879Z","caller":"traceutil/trace.go:171","msg":"trace[922379844] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"106.013206ms","start":"2026-10-15T06:26:51.813832Z","end":"2026-10-15T06:26:51.919845Z","steps":["trace[922379844] 'read index received' (duration: 77.831µs)","trace[922379844] 'applied index is now lower than readState.Index' (duration: 105.933225ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:26:51.919912Z","caller":"traceutil/trace.go:171","msg":"trace[1245270121] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"643.265344ms","start":"2026-10-15T06:26:51.276609Z","end":"2026-10-15T06:26:51.919874Z","steps":["trace[1245270121] 'process raft request' (duration: 472.373548ms)","trace[1245270121] 'compare' (duration: 170.384076ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:26:51.920003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.153389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:26:51.920035Z","caller":"traceutil/trace.go:171","msg":"trace[826354249] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:610; }","duration":"106.24793ms","start":"2026-10-15T06:26:51.813778Z","end":"2026-10-15T06:26:51.920026Z","steps":["trace[826354249] 'agreement among raft nodes before linearized reading' (duration: 106.147408ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:26:51.920045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:26:51.27658Z","time spent":"643.401606ms","remote":"127.0.0.1:44332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-15T06:27:08.652315Z","caller":"traceutil/trace.go:171","msg":"trace[1839321850] linearizableReadLoop","detail":"{readStateIndex:804; appliedIndex:803; }","duration":"370.111969ms","start":"2026-10-15T06:27:08.282183Z","end":"2026-10-15T06:27:08.652295Z","steps":["trace[1839321850] 'read index received' (duration: 369.921056ms)","trace[1839321850] 'applied index is now lower than readState.Index' (duration: 190.053µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:27:08.652457Z","caller":"traceutil/trace.go:171","msg":"trace[1769058304] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"675.369314ms","start":"2026-10-15T06:27:07.977067Z","end":"2026-10-15T06:27:08.652437Z","steps":["trace[1769058304] 'process raft request' (duration: 675.096279ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:27:08.652687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:27:07.97704Z","time spent":"675.438776ms","remote":"127.0.0.1:44252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T06:27:08.652723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.509896ms","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-10-15T06:27:08.652787Z","caller":"traceutil/trace.go:171","msg":"trace[1755417405] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:774; }","duration":"370.643459ms","start":"2026-10-15T06:27:08.282127Z","end":"2026-10-15T06:27:08.652771Z","steps":["trace[1755417405] 'agreement among raft nodes before linearized reading' (duration: 370.458466ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:27:08.652846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:27:08.282105Z","time spent":"370.7315ms","remote":"127.0.0.1:44350","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-10-15T06:27:39.215684Z","caller":"traceutil/trace.go:171","msg":"trace[1762207566] linearizableReadLoop","detail":"{readStateIndex:1208; appliedIndex:1207; }","duration":"336.282959ms","start":"2026-10-15T06:27:38.879382Z","end":"2026-10-15T06:27:39.215665Z","steps":["trace[1762207566] 'read index received' (duration: 336.133806ms)","trace[1762207566] 'applied index is now lower than readState.Index' (duration: 148.513µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:27:39.215784Z","caller":"traceutil/trace.go:171","msg":"trace[75524016] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"385.904978ms","start":"2026-10-15T06:27:38.829871Z","end":"2026-10-15T06:27:39.215776Z","steps":["trace[75524016] 'process raft request' (duration: 385.692304ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:27:39.215856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:27:38.829853Z","time spent":"385.947119ms","remote":"127.0.0.1:44350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T06:27:39.216031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.649775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-10-15T06:27:39.21605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.955117ms","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-10-15T06:27:39.216084Z","caller":"traceutil/trace.go:171","msg":"trace[1747256182] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1172; }","duration":"336.743577ms","start":"2026-10-15T06:27:38.879327Z","end":"2026-10-15T06:27:39.21607Z","steps":["trace[1747256182] 'agreement among raft nodes before linearized reading' (duration: 336.599994ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:27:39.216143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:27:38.879305Z","time spent":"336.830608ms","remote":"127.0.0.1:44350","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-10-15T06:27:39.216153Z","caller":"traceutil/trace.go:171","msg":"trace[467769039] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1172; }","duration":"334.11991ms","start":"2026-10-15T06:27:38.882009Z","end":"2026-10-15T06:27:39.216129Z","steps":["trace[467769039] 'agreement among raft nodes before linearized reading' (duration: 333.844705ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:27:39.216227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:27:38.881999Z","time spent":"334.210611ms","remote":"127.0.0.1:44350","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":"warn","ts":"2026-10-15T06:27:39.216293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.623211ms","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-10-15T06:27:39.216318Z","caller":"traceutil/trace.go:171","msg":"trace[850093154] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1172; }","duration":"161.681473ms","start":"2026-10-15T06:27:39.054628Z","end":"2026-10-15T06:27:39.21631Z","steps":["trace[850093154] 'agreement among raft nodes before linearized reading' (duration: 161.609602ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:28:01.185834Z","caller":"traceutil/trace.go:171","msg":"trace[947978044] linearizableReadLoop","detail":"{readStateIndex:1470; appliedIndex:1469; }","duration":"105.529928ms","start":"2026-10-15T06:28:01.080285Z","end":"2026-10-15T06:28:01.185815Z","steps":["trace[947978044] 'read index received' (duration: 105.370716ms)","trace[947978044] 'applied index is now lower than readState.Index' (duration: 158.312µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:28:01.185942Z","caller":"traceutil/trace.go:171","msg":"trace[232650393] transaction","detail":"{read_only:false; response_revision:1424; number_of_response:1; }","duration":"110.456582ms","start":"2026-10-15T06:28:01.075449Z","end":"2026-10-15T06:28:01.185905Z","steps":["trace[232650393] 'process raft request' (duration: 110.245308ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:28:01.186206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.899544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-10-15T06:28:01.1863Z","caller":"traceutil/trace.go:171","msg":"trace[1449274830] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1424; }","duration":"106.027316ms","start":"2026-10-15T06:28:01.080252Z","end":"2026-10-15T06:28:01.186279Z","steps":["trace[1449274830] 'agreement among raft nodes before linearized reading' (duration: 105.762382ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:28:03.45814Z","caller":"traceutil/trace.go:171","msg":"trace[1294681133] transaction","detail":"{read_only:false; response_revision:1435; number_of_response:1; }","duration":"127.722366ms","start":"2026-10-15T06:28:03.330392Z","end":"2026-10-15T06:28:03.458115Z","steps":["trace[1294681133] 'process raft request' (duration: 127.3753ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:28:03.600239Z","caller":"traceutil/trace.go:171","msg":"trace[687772694] transaction","detail":"{read_only:false; response_revision:1436; number_of_response:1; }","duration":"137.93833ms","start":"2026-10-15T06:28:03.462261Z","end":"2026-10-15T06:28:03.600199Z","steps":["trace[687772694] 'process raft request' (duration: 80.91912ms)","trace[687772694] 'compare' (duration: 56.716785ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:28:03.600298Z","caller":"traceutil/trace.go:171","msg":"trace[1547548627] transaction","detail":"{read_only:false; response_revision:1438; number_of_response:1; }","duration":"136.983145ms","start":"2026-10-15T06:28:03.463294Z","end":"2026-10-15T06:28:03.600277Z","steps":["trace[1547548627] 'process raft request' (duration: 136.860463ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:28:03.600208Z","caller":"traceutil/trace.go:171","msg":"trace[622154026] transaction","detail":"{read_only:false; response_revision:1437; number_of_response:1; }","duration":"137.177728ms","start":"2026-10-15T06:28:03.463007Z","end":"2026-10-15T06:28:03.600185Z","steps":["trace[622154026] 'process raft request' (duration: 137.047296ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:28:12.684718Z","caller":"traceutil/trace.go:171","msg":"trace[328799304] transaction","detail":"{read_only:false; response_revision:1550; number_of_response:1; }","duration":"125.644941ms","start":"2026-10-15T06:28:12.559022Z","end":"2026-10-15T06:28:12.684667Z","steps":["trace[328799304] 'process raft request' (duration: 124.327858ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:28:12.702812Z","caller":"traceutil/trace.go:171","msg":"trace[1896646293] transaction","detail":"{read_only:false; response_revision:1551; number_of_response:1; }","duration":"142.814064ms","start":"2026-10-15T06:28:12.559967Z","end":"2026-10-15T06:28:12.702781Z","steps":["trace[1896646293] 'process raft request' (duration: 142.503229ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:28:29.435444Z","caller":"traceutil/trace.go:171","msg":"trace[581211962] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"105.066005ms","start":"2026-10-15T06:28:29.330349Z","end":"2026-10-15T06:28:29.435415Z","steps":["trace[581211962] 'process raft request' (duration: 104.913873ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:28:29.775154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.112755ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-10-15T06:28:29.775439Z","caller":"traceutil/trace.go:171","msg":"trace[331879049] linearizableReadLoop","detail":"{readStateIndex:1922; appliedIndex:1920; }","duration":"102.504344ms","start":"2026-10-15T06:28:29.672916Z","end":"2026-10-15T06:28:29.77542Z","steps":["trace[331879049] 'read index received' (duration: 38.004849ms)","trace[331879049] 'applied index is now lower than readState.Index' (duration: 64.498435ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:28:29.775504Z","caller":"traceutil/trace.go:171","msg":"trace[1765914835] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"184.230416ms","start":"2026-10-15T06:28:29.591242Z","end":"2026-10-15T06:28:29.775472Z","steps":["trace[1765914835] 'process raft request' (duration: 184.009392ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:28:29.775626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.695717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c2aa4c4d-42e3-48d1-89ca-e51f3803d35d\" ","response":"range_response_count:1 size:3743"} {"level":"info","ts":"2026-10-15T06:28:29.775661Z","caller":"traceutil/trace.go:171","msg":"trace[1272082360] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c2aa4c4d-42e3-48d1-89ca-e51f3803d35d; range_end:; response_count:1; response_revision:1849; }","duration":"102.773137ms","start":"2026-10-15T06:28:29.672877Z","end":"2026-10-15T06:28:29.77565Z","steps":["trace[1272082360] 'agreement among raft nodes before linearized reading' (duration: 102.636485ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:28:44.462354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.489671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-10-15T06:28:44.46247Z","caller":"traceutil/trace.go:171","msg":"trace[1734491457] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1981; }","duration":"155.654917ms","start":"2026-10-15T06:28:44.306788Z","end":"2026-10-15T06:28:44.462443Z","steps":["trace[1734491457] 'range keys from in-memory index tree' (duration: 155.283962ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:28:44.462489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.78364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-10-15T06:28:44.462576Z","caller":"traceutil/trace.go:171","msg":"trace[1584452575] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1981; }","duration":"177.902815ms","start":"2026-10-15T06:28:44.284654Z","end":"2026-10-15T06:28:44.462557Z","steps":["trace[1584452575] 'range keys from in-memory index tree' (duration: 177.422754ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:28:44.467796Z","caller":"traceutil/trace.go:171","msg":"trace[1680409939] transaction","detail":"{read_only:false; response_revision:1982; number_of_response:1; }","duration":"127.204413ms","start":"2026-10-15T06:28:44.340579Z","end":"2026-10-15T06:28:44.467784Z","steps":["trace[1680409939] 'process raft request' (duration: 126.8826ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:29:04.007274Z","caller":"traceutil/trace.go:171","msg":"trace[98912392] transaction","detail":"{read_only:false; response_revision:2091; number_of_response:1; }","duration":"112.422594ms","start":"2026-10-15T06:29:03.894822Z","end":"2026-10-15T06:29:04.007244Z","steps":["trace[98912392] 'process raft request' (duration: 112.125883ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:29:04.699737Z","caller":"traceutil/trace.go:171","msg":"trace[457111820] linearizableReadLoop","detail":"{readStateIndex:2179; appliedIndex:2178; }","duration":"117.841631ms","start":"2026-10-15T06:29:04.581874Z","end":"2026-10-15T06:29:04.699716Z","steps":["trace[457111820] 'read index received' (duration: 117.704485ms)","trace[457111820] 'applied index is now lower than readState.Index' (duration: 136.216µs)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:29:04.699925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.039489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-10-15T06:29:04.699961Z","caller":"traceutil/trace.go:171","msg":"trace[889585949] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2099; }","duration":"118.118162ms","start":"2026-10-15T06:29:04.581833Z","end":"2026-10-15T06:29:04.699951Z","steps":["trace[889585949] 'agreement among raft nodes before linearized reading' (duration: 118.002997ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:29:04.699826Z","caller":"traceutil/trace.go:171","msg":"trace[1556787367] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"149.271794ms","start":"2026-10-15T06:29:04.550514Z","end":"2026-10-15T06:29:04.699786Z","steps":["trace[1556787367] 'process raft request' (duration: 149.068246ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:29:05.15852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.263151ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T06:29:05.158874Z","caller":"traceutil/trace.go:171","msg":"trace[1914512091] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"454.609338ms","start":"2026-10-15T06:29:04.704239Z","end":"2026-10-15T06:29:05.158848Z","steps":["trace[1914512091] 'process raft request' (duration: 338.92034ms)","trace[1914512091] 'compare' (duration: 114.967749ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:29:05.159007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:29:04.704219Z","time spent":"454.724012ms","remote":"127.0.0.1:44350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T06:29:05.609977Z","caller":"traceutil/trace.go:171","msg":"trace[862013554] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"239.715613ms","start":"2026-10-15T06:29:05.37024Z","end":"2026-10-15T06:29:05.609956Z","steps":["trace[862013554] 'process raft request' (duration: 239.562167ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:30:44.827199Z","caller":"traceutil/trace.go:171","msg":"trace[2044892539] transaction","detail":"{read_only:false; response_revision:2742; number_of_response:1; }","duration":"200.475927ms","start":"2026-10-15T06:30:44.626696Z","end":"2026-10-15T06:30:44.827172Z","steps":["trace[2044892539] 'process raft request' (duration: 200.313523ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:30:44.884274Z","caller":"traceutil/trace.go:171","msg":"trace[716452901] transaction","detail":"{read_only:false; response_revision:2743; number_of_response:1; }","duration":"253.712491ms","start":"2026-10-15T06:30:44.630536Z","end":"2026-10-15T06:30:44.884248Z","steps":["trace[716452901] 'process raft request' (duration: 218.15902ms)","trace[716452901] 'compare' (duration: 35.350615ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:30:44.884566Z","caller":"traceutil/trace.go:171","msg":"trace[1801157720] transaction","detail":"{read_only:false; response_revision:2744; number_of_response:1; }","duration":"214.707612ms","start":"2026-10-15T06:30:44.669834Z","end":"2026-10-15T06:30:44.884541Z","steps":["trace[1801157720] 'process raft request' (duration: 214.363963ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:30:44.884468Z","caller":"traceutil/trace.go:171","msg":"trace[426345990] linearizableReadLoop","detail":"{readStateIndex:2846; appliedIndex:2844; }","duration":"241.816064ms","start":"2026-10-15T06:30:44.64263Z","end":"2026-10-15T06:30:44.884446Z","steps":["trace[426345990] 'read index received' (duration: 184.467263ms)","trace[426345990] 'applied index is now lower than readState.Index' (duration: 57.346841ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:30:44.884889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.224975ms","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-10-15T06:30:44.885021Z","caller":"traceutil/trace.go:171","msg":"trace[447253961] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2744; }","duration":"242.39195ms","start":"2026-10-15T06:30:44.642579Z","end":"2026-10-15T06:30:44.884971Z","steps":["trace[447253961] 'agreement among raft nodes before linearized reading' (duration: 242.06576ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:30:44.885719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.252271ms","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-10-15T06:30:44.885783Z","caller":"traceutil/trace.go:171","msg":"trace[1496846482] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2744; }","duration":"207.368504ms","start":"2026-10-15T06:30:44.678398Z","end":"2026-10-15T06:30:44.885767Z","steps":["trace[1496846482] 'agreement among raft nodes before linearized reading' (duration: 207.179169ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:30:45.201212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.959671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18dea02ee5e382a8\" ","response":"range_response_count:1 size:779"} {"level":"info","ts":"2026-10-15T06:30:45.20131Z","caller":"traceutil/trace.go:171","msg":"trace[2070507216] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18dea02ee5e382a8; range_end:; response_count:1; response_revision:2746; }","duration":"174.104905ms","start":"2026-10-15T06:30:45.027181Z","end":"2026-10-15T06:30:45.201286Z","steps":["trace[2070507216] 'range keys from in-memory index tree' (duration: 173.729255ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:30:45.270602Z","caller":"traceutil/trace.go:171","msg":"trace[2123368587] transaction","detail":"{read_only:false; response_revision:2747; number_of_response:1; }","duration":"121.00679ms","start":"2026-10-15T06:30:45.149557Z","end":"2026-10-15T06:30:45.270564Z","steps":["trace[2123368587] 'process raft request' (duration: 120.820005ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:11.279611Z","caller":"traceutil/trace.go:171","msg":"trace[384249968] transaction","detail":"{read_only:false; response_revision:4656; number_of_response:1; }","duration":"132.728834ms","start":"2026-10-15T06:35:11.146847Z","end":"2026-10-15T06:35:11.279576Z","steps":["trace[384249968] 'process raft request' (duration: 78.12657ms)","trace[384249968] 'compare' (duration: 54.39979ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:35:11.280495Z","caller":"traceutil/trace.go:171","msg":"trace[732714612] transaction","detail":"{read_only:false; response_revision:4657; number_of_response:1; }","duration":"133.03906ms","start":"2026-10-15T06:35:11.147438Z","end":"2026-10-15T06:35:11.280477Z","steps":["trace[732714612] 'process raft request' (duration: 132.04048ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:11.280732Z","caller":"traceutil/trace.go:171","msg":"trace[2066938582] transaction","detail":"{read_only:false; response_revision:4659; number_of_response:1; }","duration":"132.46164ms","start":"2026-10-15T06:35:11.148245Z","end":"2026-10-15T06:35:11.280707Z","steps":["trace[2066938582] 'process raft request' (duration: 132.164663ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:11.280792Z","caller":"traceutil/trace.go:171","msg":"trace[1024507376] transaction","detail":"{read_only:false; response_revision:4658; number_of_response:1; }","duration":"132.97116ms","start":"2026-10-15T06:35:11.147807Z","end":"2026-10-15T06:35:11.280778Z","steps":["trace[1024507376] 'process raft request' (duration: 132.562971ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:11.433012Z","caller":"traceutil/trace.go:171","msg":"trace[444343468] transaction","detail":"{read_only:false; response_revision:4662; number_of_response:1; }","duration":"134.145943ms","start":"2026-10-15T06:35:11.298847Z","end":"2026-10-15T06:35:11.432993Z","steps":["trace[444343468] 'process raft request' (duration: 133.589912ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:11.432913Z","caller":"traceutil/trace.go:171","msg":"trace[1382336215] transaction","detail":"{read_only:false; response_revision:4663; number_of_response:1; }","duration":"112.330032ms","start":"2026-10-15T06:35:11.320553Z","end":"2026-10-15T06:35:11.432883Z","steps":["trace[1382336215] 'process raft request' (duration: 112.148428ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:11.725334Z","caller":"traceutil/trace.go:171","msg":"trace[1894344274] transaction","detail":"{read_only:false; response_revision:4691; number_of_response:1; }","duration":"100.83631ms","start":"2026-10-15T06:35:11.624467Z","end":"2026-10-15T06:35:11.725303Z","steps":["trace[1894344274] 'process raft request' (duration: 38.812915ms)","trace[1894344274] 'compare' (duration: 61.870612ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:35:11.729087Z","caller":"traceutil/trace.go:171","msg":"trace[535264373] transaction","detail":"{read_only:false; response_revision:4692; number_of_response:1; }","duration":"103.025954ms","start":"2026-10-15T06:35:11.626006Z","end":"2026-10-15T06:35:11.729032Z","steps":["trace[535264373] 'process raft request' (duration: 102.794788ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:12.278684Z","caller":"traceutil/trace.go:171","msg":"trace[624711318] transaction","detail":"{read_only:false; response_revision:4719; number_of_response:1; }","duration":"106.145856ms","start":"2026-10-15T06:35:12.172517Z","end":"2026-10-15T06:35:12.278663Z","steps":["trace[624711318] 'process raft request' (duration: 106.021554ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:35:12.279029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.990892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:15300"} {"level":"info","ts":"2026-10-15T06:35:12.279112Z","caller":"traceutil/trace.go:171","msg":"trace[1102679786] range","detail":"{range_begin:/registry/statefulsets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4719; }","duration":"103.103775ms","start":"2026-10-15T06:35:12.175985Z","end":"2026-10-15T06:35:12.279089Z","steps":["trace[1102679786] 'agreement among raft nodes before linearized reading' (duration: 102.819229ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:35:12.280032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.345229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:7 size:60727"} {"level":"info","ts":"2026-10-15T06:35:12.28019Z","caller":"traceutil/trace.go:171","msg":"trace[1702393227] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:7; response_revision:4719; }","duration":"105.502452ms","start":"2026-10-15T06:35:12.174637Z","end":"2026-10-15T06:35:12.280139Z","steps":["trace[1702393227] 'agreement among raft nodes before linearized reading' (duration: 104.059954ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:12.793084Z","caller":"traceutil/trace.go:171","msg":"trace[435489766] linearizableReadLoop","detail":"{readStateIndex:4914; appliedIndex:4913; }","duration":"181.463127ms","start":"2026-10-15T06:35:12.611593Z","end":"2026-10-15T06:35:12.793056Z","steps":["trace[435489766] 'read index received' (duration: 181.215212ms)","trace[435489766] 'applied index is now lower than readState.Index' (duration: 246.845µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:35:12.79322Z","caller":"traceutil/trace.go:171","msg":"trace[487440134] transaction","detail":"{read_only:false; response_revision:4733; number_of_response:1; }","duration":"205.877081ms","start":"2026-10-15T06:35:12.587329Z","end":"2026-10-15T06:35:12.793206Z","steps":["trace[487440134] 'process raft request' (duration: 205.565375ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:35:12.794522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.903617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207411"} {"level":"info","ts":"2026-10-15T06:35:12.794603Z","caller":"traceutil/trace.go:171","msg":"trace[46209333] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4733; }","duration":"183.03031ms","start":"2026-10-15T06:35:12.611553Z","end":"2026-10-15T06:35:12.794584Z","steps":["trace[46209333] 'agreement among raft nodes before linearized reading' (duration: 181.853395ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:14.473216Z","caller":"traceutil/trace.go:171","msg":"trace[1571017267] transaction","detail":"{read_only:false; response_revision:4759; number_of_response:1; }","duration":"106.553222ms","start":"2026-10-15T06:35:14.366631Z","end":"2026-10-15T06:35:14.473185Z","steps":["trace[1571017267] 'process raft request' (duration: 106.45593ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:14.473245Z","caller":"traceutil/trace.go:171","msg":"trace[829210431] transaction","detail":"{read_only:false; response_revision:4757; number_of_response:1; }","duration":"107.94808ms","start":"2026-10-15T06:35:14.365268Z","end":"2026-10-15T06:35:14.473216Z","steps":["trace[829210431] 'process raft request' (duration: 11.578383ms)","trace[829210431] 'compare' (duration: 96.01187ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:35:14.473234Z","caller":"traceutil/trace.go:171","msg":"trace[1143934287] transaction","detail":"{read_only:false; response_revision:4758; number_of_response:1; }","duration":"107.693575ms","start":"2026-10-15T06:35:14.365488Z","end":"2026-10-15T06:35:14.473182Z","steps":["trace[1143934287] 'process raft request' (duration: 107.524312ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:14.473542Z","caller":"traceutil/trace.go:171","msg":"trace[956448229] transaction","detail":"{read_only:false; response_revision:4760; number_of_response:1; }","duration":"106.348849ms","start":"2026-10-15T06:35:14.367166Z","end":"2026-10-15T06:35:14.473515Z","steps":["trace[956448229] 'process raft request' (duration: 105.957971ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:19.64344Z","caller":"traceutil/trace.go:171","msg":"trace[209159460] linearizableReadLoop","detail":"{readStateIndex:5055; appliedIndex:5054; }","duration":"149.432223ms","start":"2026-10-15T06:35:19.493985Z","end":"2026-10-15T06:35:19.643417Z","steps":["trace[209159460] 'read index received' (duration: 98.69596ms)","trace[209159460] 'applied index is now lower than readState.Index' (duration: 50.735353ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:35:19.643553Z","caller":"traceutil/trace.go:171","msg":"trace[2141934241] transaction","detail":"{read_only:false; response_revision:4868; number_of_response:1; }","duration":"150.381151ms","start":"2026-10-15T06:35:19.493161Z","end":"2026-10-15T06:35:19.643542Z","steps":["trace[2141934241] 'process raft request' (duration: 99.601638ms)","trace[2141934241] 'compare' (duration: 50.516648ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:35:19.643928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.946553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-sxjpk-tls-hfb2r\" ","response":"range_response_count:1 size:2625"} {"level":"info","ts":"2026-10-15T06:35:19.643976Z","caller":"traceutil/trace.go:171","msg":"trace[347727072] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-sxjpk-tls-hfb2r; range_end:; response_count:1; response_revision:4868; }","duration":"150.022114ms","start":"2026-10-15T06:35:19.493941Z","end":"2026-10-15T06:35:19.643963Z","steps":["trace[347727072] 'agreement among raft nodes before linearized reading' (duration: 149.910871ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:35:19.64382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.097055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-10-15T06:35:19.644437Z","caller":"traceutil/trace.go:171","msg":"trace[1458086757] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4868; }","duration":"149.758938ms","start":"2026-10-15T06:35:19.494667Z","end":"2026-10-15T06:35:19.644426Z","steps":["trace[1458086757] 'agreement among raft nodes before linearized reading' (duration: 148.988753ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:19.811957Z","caller":"traceutil/trace.go:171","msg":"trace[579061165] linearizableReadLoop","detail":"{readStateIndex:5059; appliedIndex:5058; }","duration":"102.713181ms","start":"2026-10-15T06:35:19.709221Z","end":"2026-10-15T06:35:19.811934Z","steps":["trace[579061165] 'read index received' (duration: 95.605057ms)","trace[579061165] 'applied index is now lower than readState.Index' (duration: 7.106894ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:35:19.812076Z","caller":"traceutil/trace.go:171","msg":"trace[1604019377] transaction","detail":"{read_only:false; response_revision:4872; number_of_response:1; }","duration":"112.471866ms","start":"2026-10-15T06:35:19.699586Z","end":"2026-10-15T06:35:19.812058Z","steps":["trace[1604019377] 'process raft request' (duration: 105.305562ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:35:19.812372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.238263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-10-15T06:35:19.812487Z","caller":"traceutil/trace.go:171","msg":"trace[760303147] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4872; }","duration":"118.401705ms","start":"2026-10-15T06:35:19.694064Z","end":"2026-10-15T06:35:19.812465Z","steps":["trace[760303147] 'agreement among raft nodes before linearized reading' (duration: 118.13574ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:35:19.812975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.395017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-10-15T06:35:19.813034Z","caller":"traceutil/trace.go:171","msg":"trace[784355376] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4872; }","duration":"123.455588ms","start":"2026-10-15T06:35:19.689563Z","end":"2026-10-15T06:35:19.813019Z","steps":["trace[784355376] 'agreement among raft nodes before linearized reading' (duration: 123.314446ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:25.854264Z","caller":"traceutil/trace.go:171","msg":"trace[458382730] linearizableReadLoop","detail":"{readStateIndex:5159; appliedIndex:5158; }","duration":"111.274418ms","start":"2026-10-15T06:35:25.742964Z","end":"2026-10-15T06:35:25.854238Z","steps":["trace[458382730] 'read index received' (duration: 111.072674ms)","trace[458382730] 'applied index is now lower than readState.Index' (duration: 200.504µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:35:25.854309Z","caller":"traceutil/trace.go:171","msg":"trace[270659049] transaction","detail":"{read_only:false; response_revision:4970; number_of_response:1; }","duration":"111.92213ms","start":"2026-10-15T06:35:25.74236Z","end":"2026-10-15T06:35:25.854282Z","steps":["trace[270659049] 'process raft request' (duration: 111.727847ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:35:25.855124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.148265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-10-15T06:35:25.855414Z","caller":"traceutil/trace.go:171","msg":"trace[1720126887] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4970; }","duration":"112.372519ms","start":"2026-10-15T06:35:25.742915Z","end":"2026-10-15T06:35:25.855287Z","steps":["trace[1720126887] 'agreement among raft nodes before linearized reading' (duration: 111.468041ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:26.153238Z","caller":"traceutil/trace.go:171","msg":"trace[1205907310] transaction","detail":"{read_only:false; response_revision:4971; number_of_response:1; }","duration":"293.963409ms","start":"2026-10-15T06:35:25.859228Z","end":"2026-10-15T06:35:26.153191Z","steps":["trace[1205907310] 'process raft request' (duration: 246.612277ms)","trace[1205907310] 'compare' (duration: 47.000804ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:35:26.540412Z","caller":"traceutil/trace.go:171","msg":"trace[1655281067] transaction","detail":"{read_only:false; response_revision:4974; number_of_response:1; }","duration":"203.099702ms","start":"2026-10-15T06:35:26.337288Z","end":"2026-10-15T06:35:26.540388Z","steps":["trace[1655281067] 'process raft request' (duration: 202.969579ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:26.60512Z","caller":"traceutil/trace.go:171","msg":"trace[1789029741] transaction","detail":"{read_only:false; response_revision:4975; number_of_response:1; }","duration":"260.612407ms","start":"2026-10-15T06:35:26.344477Z","end":"2026-10-15T06:35:26.605089Z","steps":["trace[1789029741] 'process raft request' (duration: 260.427064ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:35:26.648076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.285165ms","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-10-15T06:35:26.648242Z","caller":"traceutil/trace.go:171","msg":"trace[1942878613] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4976; }","duration":"108.527092ms","start":"2026-10-15T06:35:26.539698Z","end":"2026-10-15T06:35:26.648225Z","steps":["trace[1942878613] 'agreement among raft nodes before linearized reading' (duration: 108.251566ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:26.721908Z","caller":"traceutil/trace.go:171","msg":"trace[610438733] transaction","detail":"{read_only:false; response_revision:4977; number_of_response:1; }","duration":"111.43372ms","start":"2026-10-15T06:35:26.610441Z","end":"2026-10-15T06:35:26.721875Z","steps":["trace[610438733] 'process raft request' (duration: 88.868115ms)","trace[610438733] 'compare' (duration: 21.514613ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:35:26.722053Z","caller":"traceutil/trace.go:171","msg":"trace[1238608544] transaction","detail":"{read_only:false; response_revision:4979; number_of_response:1; }","duration":"110.168344ms","start":"2026-10-15T06:35:26.611844Z","end":"2026-10-15T06:35:26.722012Z","steps":["trace[1238608544] 'process raft request' (duration: 109.256505ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:26.722088Z","caller":"traceutil/trace.go:171","msg":"trace[421668253] transaction","detail":"{read_only:false; response_revision:4978; number_of_response:1; }","duration":"111.195205ms","start":"2026-10-15T06:35:26.610867Z","end":"2026-10-15T06:35:26.722062Z","steps":["trace[421668253] 'process raft request' (duration: 110.146354ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:35:26.722313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.811278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5cf39ce6-482f-4209-9872-c9d7989588dc\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-10-15T06:35:26.722377Z","caller":"traceutil/trace.go:171","msg":"trace[1082045660] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5cf39ce6-482f-4209-9872-c9d7989588dc; range_end:; response_count:1; response_revision:4981; }","duration":"111.929969ms","start":"2026-10-15T06:35:26.61043Z","end":"2026-10-15T06:35:26.72236Z","steps":["trace[1082045660] 'agreement among raft nodes before linearized reading' (duration: 111.735975ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:29.109534Z","caller":"traceutil/trace.go:171","msg":"trace[2134761489] transaction","detail":"{read_only:false; response_revision:5016; number_of_response:1; }","duration":"114.425137ms","start":"2026-10-15T06:35:28.99509Z","end":"2026-10-15T06:35:29.109515Z","steps":["trace[2134761489] 'process raft request' (duration: 114.10997ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:39.075044Z","caller":"traceutil/trace.go:171","msg":"trace[465580493] linearizableReadLoop","detail":"{readStateIndex:5327; appliedIndex:5326; }","duration":"312.835837ms","start":"2026-10-15T06:35:38.762178Z","end":"2026-10-15T06:35:39.075014Z","steps":["trace[465580493] 'read index received' (duration: 279.391898ms)","trace[465580493] 'applied index is now lower than readState.Index' (duration: 33.442739ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:35:39.075358Z","caller":"traceutil/trace.go:171","msg":"trace[2114761863] transaction","detail":"{read_only:false; response_revision:5134; number_of_response:1; }","duration":"389.999881ms","start":"2026-10-15T06:35:38.685335Z","end":"2026-10-15T06:35:39.075335Z","steps":["trace[2114761863] 'process raft request' (duration: 356.331898ms)","trace[2114761863] 'compare' (duration: 32.836377ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:35:39.075496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:35:38.685305Z","time spent":"390.102464ms","remote":"127.0.0.1:44350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T06:35:39.075741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.346668ms","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-10-15T06:35:39.075822Z","caller":"traceutil/trace.go:171","msg":"trace[278950871] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5134; }","duration":"297.466281ms","start":"2026-10-15T06:35:38.778337Z","end":"2026-10-15T06:35:39.075803Z","steps":["trace[278950871] 'agreement among raft nodes before linearized reading' (duration: 297.215296ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:35:39.075899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.941489ms","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-10-15T06:35:39.075954Z","caller":"traceutil/trace.go:171","msg":"trace[287744516] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5134; }","duration":"112.0275ms","start":"2026-10-15T06:35:38.963912Z","end":"2026-10-15T06:35:39.07594Z","steps":["trace[287744516] 'agreement among raft nodes before linearized reading' (duration: 111.889367ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:35:39.076025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.108563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-15T06:35:39.076061Z","caller":"traceutil/trace.go:171","msg":"trace[754687553] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:5134; }","duration":"224.183524ms","start":"2026-10-15T06:35:38.851868Z","end":"2026-10-15T06:35:39.076052Z","steps":["trace[754687553] 'agreement among raft nodes before linearized reading' (duration: 224.125023ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:35:39.076215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.042561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-10-15T06:35:39.076256Z","caller":"traceutil/trace.go:171","msg":"trace[1412542219] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5134; }","duration":"314.124143ms","start":"2026-10-15T06:35:38.762122Z","end":"2026-10-15T06:35:39.076246Z","steps":["trace[1412542219] 'agreement among raft nodes before linearized reading' (duration: 314.020771ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:35:39.076282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:35:38.762101Z","time spent":"314.174155ms","remote":"127.0.0.1:44350","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":"warn","ts":"2026-10-15T06:35:39.076419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.4541ms","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-10-15T06:35:39.076533Z","caller":"traceutil/trace.go:171","msg":"trace[708296552] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5134; }","duration":"294.581432ms","start":"2026-10-15T06:35:38.781908Z","end":"2026-10-15T06:35:39.07649Z","steps":["trace[708296552] 'agreement among raft nodes before linearized reading' (duration: 294.272946ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:39.247407Z","caller":"traceutil/trace.go:171","msg":"trace[863112607] transaction","detail":"{read_only:false; response_revision:5141; number_of_response:1; }","duration":"101.445459ms","start":"2026-10-15T06:35:39.145918Z","end":"2026-10-15T06:35:39.247364Z","steps":["trace[863112607] 'process raft request' (duration: 53.817906ms)","trace[863112607] 'compare' (duration: 47.391608ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:35:39.427687Z","caller":"traceutil/trace.go:171","msg":"trace[1023765274] transaction","detail":"{read_only:false; response_revision:5143; number_of_response:1; }","duration":"166.095222ms","start":"2026-10-15T06:35:39.261551Z","end":"2026-10-15T06:35:39.427646Z","steps":["trace[1023765274] 'process raft request' (duration: 136.936619ms)","trace[1023765274] 'compare' (duration: 28.817836ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:35:39.565195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.188453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-10-15T06:35:39.565281Z","caller":"traceutil/trace.go:171","msg":"trace[1352322009] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5143; }","duration":"221.322136ms","start":"2026-10-15T06:35:39.343931Z","end":"2026-10-15T06:35:39.565253Z","steps":["trace[1352322009] 'agreement among raft nodes before linearized reading' (duration: 83.837847ms)","trace[1352322009] 'range keys from in-memory index tree' (duration: 137.257855ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:35:39.565556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.088811ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-10-15T06:35:40.081448Z","caller":"traceutil/trace.go:171","msg":"trace[1256158495] transaction","detail":"{read_only:false; response_revision:5146; number_of_response:1; }","duration":"254.200652ms","start":"2026-10-15T06:35:39.827214Z","end":"2026-10-15T06:35:40.081414Z","steps":["trace[1256158495] 'process raft request' (duration: 214.875646ms)","trace[1256158495] 'compare' (duration: 38.965959ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:35:40.081456Z","caller":"traceutil/trace.go:171","msg":"trace[864736302] linearizableReadLoop","detail":"{readStateIndex:5341; appliedIndex:5339; }","duration":"112.709224ms","start":"2026-10-15T06:35:39.968709Z","end":"2026-10-15T06:35:40.081418Z","steps":["trace[864736302] 'read index received' (duration: 73.393208ms)","trace[864736302] 'applied index is now lower than readState.Index' (duration: 39.314726ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:35:40.081781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.048041ms","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-10-15T06:35:40.081838Z","caller":"traceutil/trace.go:171","msg":"trace[1290090684] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:5147; }","duration":"113.169243ms","start":"2026-10-15T06:35:39.968652Z","end":"2026-10-15T06:35:40.081821Z","steps":["trace[1290090684] 'agreement among raft nodes before linearized reading' (duration: 112.888748ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:40.08188Z","caller":"traceutil/trace.go:171","msg":"trace[1544032459] transaction","detail":"{read_only:false; response_revision:5147; number_of_response:1; }","duration":"176.391257ms","start":"2026-10-15T06:35:39.905468Z","end":"2026-10-15T06:35:40.081859Z","steps":["trace[1544032459] 'process raft request' (duration: 175.821645ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:36:00.805557Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2826} {"level":"info","ts":"2026-10-15T06:36:00.908307Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2826,"took":"101.491465ms","hash":3011660883,"current-db-size-bytes":52142080,"current-db-size":"52 MB","current-db-size-in-use-bytes":27574272,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-15T06:36:00.908369Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3011660883,"revision":2826,"compact-revision":-1} {"level":"warn","ts":"2026-10-15T06:36:14.717778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.409664ms","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-10-15T06:36:14.717984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.695093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-10-15T06:36:14.718058Z","caller":"traceutil/trace.go:171","msg":"trace[1869266470] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5481; }","duration":"183.799565ms","start":"2026-10-15T06:36:14.534239Z","end":"2026-10-15T06:36:14.718039Z","steps":["trace[1869266470] 'range keys from in-memory index tree' (duration: 183.505309ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:36:14.718007Z","caller":"traceutil/trace.go:171","msg":"trace[981900684] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5481; }","duration":"157.70186ms","start":"2026-10-15T06:36:14.560278Z","end":"2026-10-15T06:36:14.717979Z","steps":["trace[981900684] 'range keys from in-memory index tree' (duration: 157.168728ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:36:14.987071Z","caller":"traceutil/trace.go:171","msg":"trace[683005001] transaction","detail":"{read_only:false; response_revision:5483; number_of_response:1; }","duration":"263.782126ms","start":"2026-10-15T06:36:14.723256Z","end":"2026-10-15T06:36:14.987038Z","steps":["trace[683005001] 'process raft request' (duration: 237.666119ms)","trace[683005001] 'compare' (duration: 25.945704ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:36:14.987368Z","caller":"traceutil/trace.go:171","msg":"trace[724776846] transaction","detail":"{read_only:false; response_revision:5484; number_of_response:1; }","duration":"263.863918ms","start":"2026-10-15T06:36:14.723475Z","end":"2026-10-15T06:36:14.987339Z","steps":["trace[724776846] 'process raft request' (duration: 263.521682ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:36:14.988465Z","caller":"traceutil/trace.go:171","msg":"trace[1545301375] transaction","detail":"{read_only:false; response_revision:5485; number_of_response:1; }","duration":"257.135435ms","start":"2026-10-15T06:36:14.731275Z","end":"2026-10-15T06:36:14.988411Z","steps":["trace[1545301375] 'process raft request' (duration: 255.960902ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:41:00.818613Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5304} {"level":"info","ts":"2026-10-15T06:41:00.91203Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5304,"took":"92.416521ms","hash":1702064744,"current-db-size-bytes":52142080,"current-db-size":"52 MB","current-db-size-in-use-bytes":18677760,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-15T06:41:00.912123Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1702064744,"revision":5304,"compact-revision":2826}