{"level":"warn","ts":"2026-06-15T12:44:57.128817Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-06-15T12:44:57.128917Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.238: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.238:2380","--initial-cluster=instance=https://199.204.45.238:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.238:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.238:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-06-15T12:44:57.128985Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-06-15T12:44:57.128997Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.238:2380"]}
{"level":"info","ts":"2026-06-15T12:44:57.129015Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-06-15T12:44:57.129681Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"]}
{"level":"info","ts":"2026-06-15T12:44:57.12975Z","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.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.238:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-06-15T12:44:57.134076Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.008016ms"}
{"level":"info","ts":"2026-06-15T12:44:57.140909Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d7dbc9f5893cc1f6","cluster-id":"823d1d08ab21430c"}
{"level":"info","ts":"2026-06-15T12:44:57.141043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=()"}
{"level":"info","ts":"2026-06-15T12:44:57.141144Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 0"}
{"level":"info","ts":"2026-06-15T12:44:57.141183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d7dbc9f5893cc1f6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-06-15T12:44:57.141219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 1"}
{"level":"info","ts":"2026-06-15T12:44:57.141274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"}
{"level":"warn","ts":"2026-06-15T12:44:57.148057Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-06-15T12:44:57.149453Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-06-15T12:44:57.150587Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-06-15T12:44:57.153947Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d7dbc9f5893cc1f6","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-06-15T12:44:57.15427Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-06-15T12:44:57.154385Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-06-15T12:44:57.154397Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-06-15T12:44:57.154215Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d7dbc9f5893cc1f6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-06-15T12:44:57.156491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"}
{"level":"info","ts":"2026-06-15T12:44:57.156613Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","added-peer-id":"d7dbc9f5893cc1f6","added-peer-peer-urls":["https://199.204.45.238:2380"]}
{"level":"info","ts":"2026-06-15T12:44:57.160147Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-06-15T12:44:57.160193Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.238:2380"}
{"level":"info","ts":"2026-06-15T12:44:57.160259Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.238:2380"}
{"level":"info","ts":"2026-06-15T12:44:57.161932Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-06-15T12:44:57.161867Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d7dbc9f5893cc1f6","initial-advertise-peer-urls":["https://199.204.45.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-06-15T12:44:57.741594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 is starting a new election at term 1"}
{"level":"info","ts":"2026-06-15T12:44:57.741634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became pre-candidate at term 1"}
{"level":"info","ts":"2026-06-15T12:44:57.74166Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgPreVoteResp from d7dbc9f5893cc1f6 at term 1"}
{"level":"info","ts":"2026-06-15T12:44:57.741671Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became candidate at term 2"}
{"level":"info","ts":"2026-06-15T12:44:57.741678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgVoteResp from d7dbc9f5893cc1f6 at term 2"}
{"level":"info","ts":"2026-06-15T12:44:57.741693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became leader at term 2"}
{"level":"info","ts":"2026-06-15T12:44:57.741704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d7dbc9f5893cc1f6 elected leader d7dbc9f5893cc1f6 at term 2"}
{"level":"info","ts":"2026-06-15T12:44:57.742975Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d7dbc9f5893cc1f6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.238:2379]}","request-path":"/0/members/d7dbc9f5893cc1f6/attributes","cluster-id":"823d1d08ab21430c","publish-timeout":"7s"}
{"level":"info","ts":"2026-06-15T12:44:57.743014Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-06-15T12:44:57.743182Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-06-15T12:44:57.743372Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-06-15T12:44:57.743368Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-06-15T12:44:57.743703Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-06-15T12:44:57.744136Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","cluster-version":"3.5"}
{"level":"info","ts":"2026-06-15T12:44:57.744242Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-06-15T12:44:57.74427Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-06-15T12:44:57.744573Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.238:2379"}
{"level":"info","ts":"2026-06-15T12:44:57.746529Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-06-15T12:45:00.662903Z","caller":"traceutil/trace.go:171","msg":"trace[1256122208] transaction","detail":"{read_only:false; response_revision:196; number_of_response:1; }","duration":"104.995841ms","start":"2026-06-15T12:45:00.557869Z","end":"2026-06-15T12:45:00.662865Z","steps":["trace[1256122208] 'process raft request'  (duration: 99.356895ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:45:13.512036Z","caller":"traceutil/trace.go:171","msg":"trace[455612414] linearizableReadLoop","detail":"{readStateIndex:423; appliedIndex:422; }","duration":"162.951821ms","start":"2026-06-15T12:45:13.34906Z","end":"2026-06-15T12:45:13.512012Z","steps":["trace[455612414] 'read index received'  (duration: 162.772127ms)","trace[455612414] 'applied index is now lower than readState.Index'  (duration: 178.754µs)"],"step_count":2}
{"level":"info","ts":"2026-06-15T12:45:13.512107Z","caller":"traceutil/trace.go:171","msg":"trace[985557332] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"166.723783ms","start":"2026-06-15T12:45:13.345344Z","end":"2026-06-15T12:45:13.512068Z","steps":["trace[985557332] 'process raft request'  (duration: 166.536658ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T12:45:13.512276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.195318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-06-15T12:45:13.512397Z","caller":"traceutil/trace.go:171","msg":"trace[917940649] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:407; }","duration":"163.369062ms","start":"2026-06-15T12:45:13.34901Z","end":"2026-06-15T12:45:13.512379Z","steps":["trace[917940649] 'agreement among raft nodes before linearized reading'  (duration: 163.148637ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:45:13.919005Z","caller":"traceutil/trace.go:171","msg":"trace[95358782] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"402.532454ms","start":"2026-06-15T12:45:13.516449Z","end":"2026-06-15T12:45:13.918982Z","steps":["trace[95358782] 'process raft request'  (duration: 402.401841ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T12:45:13.91986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:45:13.516425Z","time spent":"402.646507ms","remote":"127.0.0.1:56500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:403 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-06-15T12:45:14.180874Z","caller":"traceutil/trace.go:171","msg":"trace[1018499630] linearizableReadLoop","detail":"{readStateIndex:425; appliedIndex:423; }","duration":"614.315077ms","start":"2026-06-15T12:45:13.566536Z","end":"2026-06-15T12:45:14.180851Z","steps":["trace[1018499630] 'read index received'  (duration: 352.347778ms)","trace[1018499630] 'applied index is now lower than readState.Index'  (duration: 261.966309ms)"],"step_count":2}
{"level":"info","ts":"2026-06-15T12:45:14.181014Z","caller":"traceutil/trace.go:171","msg":"trace[2126605664] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"661.366397ms","start":"2026-06-15T12:45:13.519537Z","end":"2026-06-15T12:45:14.180903Z","steps":["trace[2126605664] 'process raft request'  (duration: 661.176093ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T12:45:14.181041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.476311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-06-15T12:45:14.181305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:45:13.51952Z","time spent":"661.682465ms","remote":"127.0.0.1:56436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4311,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:324 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:4253 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" > >"}
{"level":"info","ts":"2026-06-15T12:45:14.181348Z","caller":"traceutil/trace.go:171","msg":"trace[1734398569] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:409; }","duration":"614.82114ms","start":"2026-06-15T12:45:13.566511Z","end":"2026-06-15T12:45:14.181332Z","steps":["trace[1734398569] 'agreement among raft nodes before linearized reading'  (duration: 614.4285ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T12:45:14.181399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:45:13.566498Z","time spent":"614.884771ms","remote":"127.0.0.1:56500","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-06-15T12:45:14.329043Z","caller":"traceutil/trace.go:171","msg":"trace[1127509851] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"143.732031ms","start":"2026-06-15T12:45:14.185278Z","end":"2026-06-15T12:45:14.32901Z","steps":["trace[1127509851] 'process raft request'  (duration: 121.812555ms)","trace[1127509851] 'compare'  (duration: 21.760382ms)"],"step_count":2}
{"level":"info","ts":"2026-06-15T12:45:14.333291Z","caller":"traceutil/trace.go:171","msg":"trace[82545859] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"141.331764ms","start":"2026-06-15T12:45:14.191942Z","end":"2026-06-15T12:45:14.333274Z","steps":["trace[82545859] 'process raft request'  (duration: 140.967705ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:45:34.568342Z","caller":"traceutil/trace.go:171","msg":"trace[2047300198] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"251.416174ms","start":"2026-06-15T12:45:34.31689Z","end":"2026-06-15T12:45:34.568306Z","steps":["trace[2047300198] 'process raft request'  (duration: 245.278017ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:45:34.568439Z","caller":"traceutil/trace.go:171","msg":"trace[469171455] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"250.988775ms","start":"2026-06-15T12:45:34.317416Z","end":"2026-06-15T12:45:34.568405Z","steps":["trace[469171455] 'process raft request'  (duration: 250.757999ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:45:34.568365Z","caller":"traceutil/trace.go:171","msg":"trace[1182384323] linearizableReadLoop","detail":"{readStateIndex:594; appliedIndex:591; }","duration":"138.31912ms","start":"2026-06-15T12:45:34.43002Z","end":"2026-06-15T12:45:34.568339Z","steps":["trace[1182384323] 'read index received'  (duration: 132.156292ms)","trace[1182384323] 'applied index is now lower than readState.Index'  (duration: 6.161798ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-15T12:45:34.568509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.461913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-06-15T12:45:34.568561Z","caller":"traceutil/trace.go:171","msg":"trace[1752107196] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:571; }","duration":"138.564206ms","start":"2026-06-15T12:45:34.429982Z","end":"2026-06-15T12:45:34.568546Z","steps":["trace[1752107196] 'agreement among raft nodes before linearized reading'  (duration: 138.435233ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:45:34.568511Z","caller":"traceutil/trace.go:171","msg":"trace[382798057] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"243.515646ms","start":"2026-06-15T12:45:34.324932Z","end":"2026-06-15T12:45:34.568447Z","steps":["trace[382798057] 'process raft request'  (duration: 243.337701ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T12:45:40.292942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.171754ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976533089653471847 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" value_size:994 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-06-15T12:45:40.29303Z","caller":"traceutil/trace.go:171","msg":"trace[532588357] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"140.332419ms","start":"2026-06-15T12:45:40.152683Z","end":"2026-06-15T12:45:40.293015Z","steps":["trace[532588357] 'process raft request'  (duration: 24.934599ms)","trace[532588357] 'compare'  (duration: 115.072282ms)"],"step_count":2}
{"level":"info","ts":"2026-06-15T12:45:41.111971Z","caller":"traceutil/trace.go:171","msg":"trace[812584283] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:657; }","duration":"266.495917ms","start":"2026-06-15T12:45:40.84542Z","end":"2026-06-15T12:45:41.111916Z","steps":["trace[812584283] 'read index received'  (duration: 243.845423ms)","trace[812584283] 'applied index is now lower than readState.Index'  (duration: 22.649014ms)"],"step_count":2}
{"level":"info","ts":"2026-06-15T12:45:41.112024Z","caller":"traceutil/trace.go:171","msg":"trace[2143657453] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"301.394705ms","start":"2026-06-15T12:45:40.81059Z","end":"2026-06-15T12:45:41.111985Z","steps":["trace[2143657453] 'process raft request'  (duration: 278.649739ms)","trace[2143657453] 'compare'  (duration: 22.469179ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-15T12:45:41.112201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:45:40.810525Z","time spent":"301.5877ms","remote":"127.0.0.1:56436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-rtlft\" mod_revision:518 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-rtlft\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-rtlft\" > >"}
{"level":"warn","ts":"2026-06-15T12:45:41.112202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.770704ms","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-06-15T12:45:41.112261Z","caller":"traceutil/trace.go:171","msg":"trace[1798388597] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:633; }","duration":"266.844656ms","start":"2026-06-15T12:45:40.845402Z","end":"2026-06-15T12:45:41.112247Z","steps":["trace[1798388597] 'agreement among raft nodes before linearized reading'  (duration: 266.671132ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T12:45:41.118525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.632914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.238\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-06-15T12:45:41.118608Z","caller":"traceutil/trace.go:171","msg":"trace[1020357776] range","detail":"{range_begin:/registry/masterleases/199.204.45.238; range_end:; response_count:1; response_revision:634; }","duration":"172.752037ms","start":"2026-06-15T12:45:40.945836Z","end":"2026-06-15T12:45:41.118588Z","steps":["trace[1020357776] 'agreement among raft nodes before linearized reading'  (duration: 172.595693ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:45:41.118907Z","caller":"traceutil/trace.go:171","msg":"trace[931010023] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"268.452023ms","start":"2026-06-15T12:45:40.850445Z","end":"2026-06-15T12:45:41.118897Z","steps":["trace[931010023] 'process raft request'  (duration: 267.87756ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:45:41.77658Z","caller":"traceutil/trace.go:171","msg":"trace[643236343] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"245.348748ms","start":"2026-06-15T12:45:41.531204Z","end":"2026-06-15T12:45:41.776553Z","steps":["trace[643236343] 'process raft request'  (duration: 243.396671ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:45:43.004772Z","caller":"traceutil/trace.go:171","msg":"trace[1142555642] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"140.303318ms","start":"2026-06-15T12:45:42.864444Z","end":"2026-06-15T12:45:43.004747Z","steps":["trace[1142555642] 'process raft request'  (duration: 140.154854ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:45:43.007694Z","caller":"traceutil/trace.go:171","msg":"trace[400753931] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"123.624457ms","start":"2026-06-15T12:45:42.884052Z","end":"2026-06-15T12:45:43.007676Z","steps":["trace[400753931] 'process raft request'  (duration: 123.455833ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:45:43.007809Z","caller":"traceutil/trace.go:171","msg":"trace[1721621030] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"123.472074ms","start":"2026-06-15T12:45:42.884327Z","end":"2026-06-15T12:45:43.007799Z","steps":["trace[1721621030] 'process raft request'  (duration: 123.265129ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:45:55.28288Z","caller":"traceutil/trace.go:171","msg":"trace[1784399511] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"100.849831ms","start":"2026-06-15T12:45:55.182002Z","end":"2026-06-15T12:45:55.282852Z","steps":["trace[1784399511] 'process raft request'  (duration: 100.690757ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:46:29.601172Z","caller":"traceutil/trace.go:171","msg":"trace[1519202340] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"102.650174ms","start":"2026-06-15T12:46:29.498497Z","end":"2026-06-15T12:46:29.601147Z","steps":["trace[1519202340] 'process raft request'  (duration: 102.331416ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:46:45.331864Z","caller":"traceutil/trace.go:171","msg":"trace[1578455385] transaction","detail":"{read_only:false; response_revision:1346; number_of_response:1; }","duration":"122.216706ms","start":"2026-06-15T12:46:45.209618Z","end":"2026-06-15T12:46:45.331834Z","steps":["trace[1578455385] 'process raft request'  (duration: 119.03605ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T12:47:16.8158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.757134ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976533089653474299 > lease_revoke:<id:41f69ecb5049c210>","response":"size:29"}
{"level":"info","ts":"2026-06-15T12:47:16.816269Z","caller":"traceutil/trace.go:171","msg":"trace[208522736] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"426.326784ms","start":"2026-06-15T12:47:16.389871Z","end":"2026-06-15T12:47:16.816197Z","steps":["trace[208522736] 'process raft request'  (duration: 426.040817ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:47:16.81634Z","caller":"traceutil/trace.go:171","msg":"trace[320417525] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"232.366673ms","start":"2026-06-15T12:47:16.583937Z","end":"2026-06-15T12:47:16.816304Z","steps":["trace[320417525] 'process raft request'  (duration: 232.092737ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:47:16.816483Z","caller":"traceutil/trace.go:171","msg":"trace[1602508078] linearizableReadLoop","detail":"{readStateIndex:1953; appliedIndex:1951; }","duration":"352.783406ms","start":"2026-06-15T12:47:16.463471Z","end":"2026-06-15T12:47:16.816254Z","steps":["trace[1602508078] 'read index received'  (duration: 183.54859ms)","trace[1602508078] 'applied index is now lower than readState.Index'  (duration: 169.233156ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-15T12:47:16.816549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:47:16.389839Z","time spent":"426.560099ms","remote":"127.0.0.1:56500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1820 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-06-15T12:47:16.944661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.587921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-06-15T12:47:16.944799Z","caller":"traceutil/trace.go:171","msg":"trace[2097805027] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1877; }","duration":"332.764745ms","start":"2026-06-15T12:47:16.612003Z","end":"2026-06-15T12:47:16.944767Z","steps":["trace[2097805027] 'agreement among raft nodes before linearized reading'  (duration: 204.653257ms)","trace[2097805027] 'range keys from in-memory index tree'  (duration: 127.78698ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-15T12:47:16.944789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.570175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-15T12:47:16.944944Z","caller":"traceutil/trace.go:171","msg":"trace[512614270] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1877; }","duration":"425.759809ms","start":"2026-06-15T12:47:16.519151Z","end":"2026-06-15T12:47:16.944911Z","steps":["trace[512614270] 'agreement among raft nodes before linearized reading'  (duration: 297.515578ms)","trace[512614270] 'range keys from in-memory index tree'  (duration: 128.022886ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-15T12:47:16.944923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:47:16.611985Z","time spent":"332.918019ms","remote":"127.0.0.1:56500","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-06-15T12:47:16.944969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.110184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b398bc98-4522-4004-b52d-4477c3343d0d\" ","response":"range_response_count:1 size:3747"}
{"level":"warn","ts":"2026-06-15T12:47:16.944782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.240283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-06-15T12:47:16.945013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:47:16.519139Z","time spent":"425.861472ms","remote":"127.0.0.1:56250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-06-15T12:47:16.945046Z","caller":"traceutil/trace.go:171","msg":"trace[1155651760] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b398bc98-4522-4004-b52d-4477c3343d0d; range_end:; response_count:1; response_revision:1877; }","duration":"445.212287ms","start":"2026-06-15T12:47:16.499805Z","end":"2026-06-15T12:47:16.945017Z","steps":["trace[1155651760] 'agreement among raft nodes before linearized reading'  (duration: 316.819712ms)","trace[1155651760] 'range keys from in-memory index tree'  (duration: 128.238161ms)"],"step_count":2}
{"level":"info","ts":"2026-06-15T12:47:16.945065Z","caller":"traceutil/trace.go:171","msg":"trace[2040428349] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1877; }","duration":"481.621192ms","start":"2026-06-15T12:47:16.463415Z","end":"2026-06-15T12:47:16.945036Z","steps":["trace[2040428349] 'agreement among raft nodes before linearized reading'  (duration: 352.988702ms)","trace[2040428349] 'range keys from in-memory index tree'  (duration: 128.077867ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-15T12:47:16.945108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:47:16.499786Z","time spent":"445.30668ms","remote":"127.0.0.1:56436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3771,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b398bc98-4522-4004-b52d-4477c3343d0d\" "}
{"level":"warn","ts":"2026-06-15T12:47:16.945147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:47:16.463393Z","time spent":"481.725774ms","remote":"127.0.0.1:56500","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":"info","ts":"2026-06-15T12:47:17.226176Z","caller":"traceutil/trace.go:171","msg":"trace[2080948542] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"276.875213ms","start":"2026-06-15T12:47:16.949276Z","end":"2026-06-15T12:47:17.226151Z","steps":["trace[2080948542] 'process raft request'  (duration: 276.706079ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:47:17.22963Z","caller":"traceutil/trace.go:171","msg":"trace[212767386] linearizableReadLoop","detail":"{readStateIndex:1956; appliedIndex:1954; }","duration":"111.668253ms","start":"2026-06-15T12:47:17.117926Z","end":"2026-06-15T12:47:17.229594Z","steps":["trace[212767386] 'read index received'  (duration: 108.167919ms)","trace[212767386] 'applied index is now lower than readState.Index'  (duration: 3.498724ms)"],"step_count":2}
{"level":"info","ts":"2026-06-15T12:47:17.229758Z","caller":"traceutil/trace.go:171","msg":"trace[1494260404] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"279.226999ms","start":"2026-06-15T12:47:16.950439Z","end":"2026-06-15T12:47:17.229666Z","steps":["trace[1494260404] 'process raft request'  (duration: 279.001454ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T12:47:17.229861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.904419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-06-15T12:47:17.229907Z","caller":"traceutil/trace.go:171","msg":"trace[1908005189] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1879; }","duration":"112.024722ms","start":"2026-06-15T12:47:17.117868Z","end":"2026-06-15T12:47:17.229893Z","steps":["trace[1908005189] 'agreement among raft nodes before linearized reading'  (duration: 111.831707ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T12:47:56.743309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.297046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-06-15T12:47:56.743519Z","caller":"traceutil/trace.go:171","msg":"trace[1801355975] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2150; }","duration":"678.565133ms","start":"2026-06-15T12:47:56.064927Z","end":"2026-06-15T12:47:56.743492Z","steps":["trace[1801355975] 'range keys from in-memory index tree'  (duration: 677.898767ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T12:47:56.743669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:47:56.064905Z","time spent":"678.713437ms","remote":"127.0.0.1:56500","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-06-15T12:47:56.743344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.25752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1990"}
{"level":"info","ts":"2026-06-15T12:47:56.744114Z","caller":"traceutil/trace.go:171","msg":"trace[777170777] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2150; }","duration":"565.026038ms","start":"2026-06-15T12:47:56.179025Z","end":"2026-06-15T12:47:56.744051Z","steps":["trace[777170777] 'range keys from in-memory index tree'  (duration: 563.651536ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T12:47:56.744258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:47:56.179008Z","time spent":"565.204643ms","remote":"127.0.0.1:56448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2014,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "}
{"level":"info","ts":"2026-06-15T12:47:56.743698Z","caller":"traceutil/trace.go:171","msg":"trace[365358161] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"504.992293ms","start":"2026-06-15T12:47:56.238429Z","end":"2026-06-15T12:47:56.743421Z","steps":["trace[365358161] 'process raft request'  (duration: 449.104057ms)","trace[365358161] 'compare'  (duration: 55.566448ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-15T12:47:56.744561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:47:56.238403Z","time spent":"505.936225ms","remote":"127.0.0.1:56500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":473,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:2110 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:414 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-06-15T12:47:56.746757Z","caller":"traceutil/trace.go:171","msg":"trace[621391284] linearizableReadLoop","detail":"{readStateIndex:2237; appliedIndex:2235; }","duration":"245.535853ms","start":"2026-06-15T12:47:56.501177Z","end":"2026-06-15T12:47:56.746713Z","steps":["trace[621391284] 'read index received'  (duration: 186.346838ms)","trace[621391284] 'applied index is now lower than readState.Index'  (duration: 59.187325ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-15T12:47:56.747009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.802711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"warn","ts":"2026-06-15T12:47:56.747062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.280581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-15T12:47:56.747106Z","caller":"traceutil/trace.go:171","msg":"trace[447642215] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2151; }","duration":"226.367493ms","start":"2026-06-15T12:47:56.520725Z","end":"2026-06-15T12:47:56.747092Z","steps":["trace[447642215] 'agreement among raft nodes before linearized reading'  (duration: 226.147487ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:47:56.747075Z","caller":"traceutil/trace.go:171","msg":"trace[795314743] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2151; }","duration":"245.932994ms","start":"2026-06-15T12:47:56.501124Z","end":"2026-06-15T12:47:56.747057Z","steps":["trace[795314743] 'agreement among raft nodes before linearized reading'  (duration: 245.721859ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:48:08.912207Z","caller":"traceutil/trace.go:171","msg":"trace[174639292] transaction","detail":"{read_only:false; response_revision:2216; number_of_response:1; }","duration":"109.440987ms","start":"2026-06-15T12:48:08.802737Z","end":"2026-06-15T12:48:08.912178Z","steps":["trace[174639292] 'process raft request'  (duration: 109.267093ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:52:08.031982Z","caller":"traceutil/trace.go:171","msg":"trace[1999194535] transaction","detail":"{read_only:false; response_revision:3883; number_of_response:1; }","duration":"146.04303ms","start":"2026-06-15T12:52:07.885907Z","end":"2026-06-15T12:52:08.03195Z","steps":["trace[1999194535] 'process raft request'  (duration: 145.876886ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:52:08.033604Z","caller":"traceutil/trace.go:171","msg":"trace[25619521] linearizableReadLoop","detail":"{readStateIndex:4037; appliedIndex:4035; }","duration":"145.794534ms","start":"2026-06-15T12:52:07.887783Z","end":"2026-06-15T12:52:08.033578Z","steps":["trace[25619521] 'read index received'  (duration: 144.050932ms)","trace[25619521] 'applied index is now lower than readState.Index'  (duration: 1.742622ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-15T12:52:08.033815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.987168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-15T12:52:08.033995Z","caller":"traceutil/trace.go:171","msg":"trace[340849318] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:3884; }","duration":"146.229785ms","start":"2026-06-15T12:52:07.887751Z","end":"2026-06-15T12:52:08.033981Z","steps":["trace[340849318] 'agreement among raft nodes before linearized reading'  (duration: 145.982509ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:52:08.033825Z","caller":"traceutil/trace.go:171","msg":"trace[364686318] transaction","detail":"{read_only:false; response_revision:3884; number_of_response:1; }","duration":"146.652264ms","start":"2026-06-15T12:52:07.887149Z","end":"2026-06-15T12:52:08.033801Z","steps":["trace[364686318] 'process raft request'  (duration: 146.276405ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:52:13.405419Z","caller":"traceutil/trace.go:171","msg":"trace[993942601] transaction","detail":"{read_only:false; response_revision:3913; number_of_response:1; }","duration":"154.754321ms","start":"2026-06-15T12:52:13.25064Z","end":"2026-06-15T12:52:13.405394Z","steps":["trace[993942601] 'process raft request'  (duration: 154.585177ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:53:30.422954Z","caller":"traceutil/trace.go:171","msg":"trace[1705910166] transaction","detail":"{read_only:false; response_revision:4926; number_of_response:1; }","duration":"100.692745ms","start":"2026-06-15T12:53:30.322227Z","end":"2026-06-15T12:53:30.42292Z","steps":["trace[1705910166] 'process raft request'  (duration: 70.668301ms)","trace[1705910166] 'compare'  (duration: 29.840829ms)"],"step_count":2}
{"level":"info","ts":"2026-06-15T12:53:34.308156Z","caller":"traceutil/trace.go:171","msg":"trace[1810827069] linearizableReadLoop","detail":"{readStateIndex:5254; appliedIndex:5253; }","duration":"107.23647ms","start":"2026-06-15T12:53:34.200891Z","end":"2026-06-15T12:53:34.308128Z","steps":["trace[1810827069] 'read index received'  (duration: 107.168518ms)","trace[1810827069] 'applied index is now lower than readState.Index'  (duration: 66.752µs)"],"step_count":2}
{"level":"info","ts":"2026-06-15T12:53:34.308262Z","caller":"traceutil/trace.go:171","msg":"trace[560136039] transaction","detail":"{read_only:false; response_revision:5058; number_of_response:1; }","duration":"203.412766ms","start":"2026-06-15T12:53:34.104812Z","end":"2026-06-15T12:53:34.308225Z","steps":["trace[560136039] 'process raft request'  (duration: 203.15153ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T12:53:34.30867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.849705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:24 size:728651"}
{"level":"info","ts":"2026-06-15T12:53:34.308783Z","caller":"traceutil/trace.go:171","msg":"trace[2061759177] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:24; response_revision:5058; }","duration":"107.976238ms","start":"2026-06-15T12:53:34.200757Z","end":"2026-06-15T12:53:34.308733Z","steps":["trace[2061759177] 'agreement among raft nodes before linearized reading'  (duration: 107.479667ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:53:47.804107Z","caller":"traceutil/trace.go:171","msg":"trace[71760544] transaction","detail":"{read_only:false; response_revision:5323; number_of_response:1; }","duration":"109.72065ms","start":"2026-06-15T12:53:47.694358Z","end":"2026-06-15T12:53:47.804079Z","steps":["trace[71760544] 'process raft request'  (duration: 55.600912ms)","trace[71760544] 'compare'  (duration: 53.903413ms)"],"step_count":2}
{"level":"info","ts":"2026-06-15T12:53:48.541753Z","caller":"traceutil/trace.go:171","msg":"trace[1891411036] transaction","detail":"{read_only:false; response_revision:5325; number_of_response:1; }","duration":"281.102825ms","start":"2026-06-15T12:53:48.260626Z","end":"2026-06-15T12:53:48.541729Z","steps":["trace[1891411036] 'process raft request'  (duration: 280.954242ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T12:53:55.622819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.083858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-15T12:53:55.622891Z","caller":"traceutil/trace.go:171","msg":"trace[140053023] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5481; }","duration":"102.193701ms","start":"2026-06-15T12:53:55.520684Z","end":"2026-06-15T12:53:55.622878Z","steps":["trace[140053023] 'range keys from in-memory index tree'  (duration: 101.993696ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T12:53:56.322481Z","caller":"traceutil/trace.go:171","msg":"trace[1893457238] linearizableReadLoop","detail":"{readStateIndex:5691; appliedIndex:5690; }","duration":"380.185682ms","start":"2026-06-15T12:53:55.942268Z","end":"2026-06-15T12:53:56.322453Z","steps":["trace[1893457238] 'read index received'  (duration: 380.032459ms)","trace[1893457238] 'applied index is now lower than readState.Index'  (duration: 152.233µs)"],"step_count":2}
{"level":"warn","ts":"2026-06-15T12:53:56.322628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.341786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-15T12:53:56.322669Z","caller":"traceutil/trace.go:171","msg":"trace[879436464] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:5482; }","duration":"380.440888ms","start":"2026-06-15T12:53:55.942216Z","end":"2026-06-15T12:53:56.322657Z","steps":["trace[879436464] 'agreement among raft nodes before linearized reading'  (duration: 380.354876ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T12:53:56.322713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:53:55.94219Z","time spent":"380.51196ms","remote":"127.0.0.1:56462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "}
{"level":"info","ts":"2026-06-15T12:53:56.322651Z","caller":"traceutil/trace.go:171","msg":"trace[1940510412] transaction","detail":"{read_only:false; response_revision:5482; number_of_response:1; }","duration":"417.949451ms","start":"2026-06-15T12:53:55.904571Z","end":"2026-06-15T12:53:56.322521Z","steps":["trace[1940510412] 'process raft request'  (duration: 417.681135ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T12:53:56.322965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:53:55.904555Z","time spent":"418.306199ms","remote":"127.0.0.1:56500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:5389 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-06-15T12:53:56.92647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.330362ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976533089653482804 > lease_revoke:<id:41f69ecb5049e2a8>","response":"size:29"}
{"level":"info","ts":"2026-06-15T12:53:56.926748Z","caller":"traceutil/trace.go:171","msg":"trace[475613284] linearizableReadLoop","detail":"{readStateIndex:5692; appliedIndex:5691; }","duration":"604.155759ms","start":"2026-06-15T12:53:56.322551Z","end":"2026-06-15T12:53:56.926707Z","steps":["trace[475613284] 'read index received'  (duration: 203.482199ms)","trace[475613284] 'applied index is now lower than readState.Index'  (duration: 400.667ms)"],"step_count":2}
{"level":"info","ts":"2026-06-15T12:53:56.926837Z","caller":"traceutil/trace.go:171","msg":"trace[417021097] transaction","detail":"{read_only:false; response_revision:5485; number_of_response:1; }","duration":"145.201864ms","start":"2026-06-15T12:53:56.781616Z","end":"2026-06-15T12:53:56.926818Z","steps":["trace[417021097] 'process raft request'  (duration: 145.162023ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T12:53:56.927126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.36649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1990"}
{"level":"info","ts":"2026-06-15T12:53:56.927182Z","caller":"traceutil/trace.go:171","msg":"trace[340286199] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:5485; }","duration":"748.479442ms","start":"2026-06-15T12:53:56.178689Z","end":"2026-06-15T12:53:56.927168Z","steps":["trace[340286199] 'agreement among raft nodes before linearized reading'  (duration: 748.219596ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T12:53:56.927231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:53:56.178668Z","time spent":"748.550584ms","remote":"127.0.0.1:56448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2014,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "}
{"level":"info","ts":"2026-06-15T12:53:56.927248Z","caller":"traceutil/trace.go:171","msg":"trace[803715432] transaction","detail":"{read_only:false; response_revision:5483; number_of_response:1; }","duration":"363.044235ms","start":"2026-06-15T12:53:56.564193Z","end":"2026-06-15T12:53:56.927237Z","steps":["trace[803715432] 'process raft request'  (duration: 362.40495ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T12:53:56.927346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:53:56.564169Z","time spent":"363.107157ms","remote":"127.0.0.1:56500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5445 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-06-15T12:53:56.927542Z","caller":"traceutil/trace.go:171","msg":"trace[1660985961] transaction","detail":"{read_only:false; response_revision:5484; number_of_response:1; }","duration":"355.483775ms","start":"2026-06-15T12:53:56.572025Z","end":"2026-06-15T12:53:56.927509Z","steps":["trace[1660985961] 'process raft request'  (duration: 354.709017ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T12:53:56.927671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"852.903896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-qzzrl\" ","response":"range_response_count:1 size:6445"}
{"level":"info","ts":"2026-06-15T12:53:56.92773Z","caller":"traceutil/trace.go:171","msg":"trace[1545653970] range","detail":"{range_begin:/registry/pods/openstack/keepalived-qzzrl; range_end:; response_count:1; response_revision:5485; }","duration":"853.001848ms","start":"2026-06-15T12:53:56.074714Z","end":"2026-06-15T12:53:56.927715Z","steps":["trace[1545653970] 'agreement among raft nodes before linearized reading'  (duration: 852.799834ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T12:53:56.927732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:53:56.572015Z","time spent":"355.628039ms","remote":"127.0.0.1:56500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:5448 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-06-15T12:53:56.927773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:53:56.07469Z","time spent":"853.071269ms","remote":"127.0.0.1:56436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6469,"request content":"key:\"/registry/pods/openstack/keepalived-qzzrl\" "}
{"level":"warn","ts":"2026-06-15T12:53:56.927945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.319619ms","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-06-15T12:53:56.927982Z","caller":"traceutil/trace.go:171","msg":"trace[1227857879] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5485; }","duration":"201.357979ms","start":"2026-06-15T12:53:56.726613Z","end":"2026-06-15T12:53:56.927971Z","steps":["trace[1227857879] 'agreement among raft nodes before linearized reading'  (duration: 201.225876ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T12:53:56.927972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.02079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-13ed4a89-b306-4e6b-836a-7aa13aacc056\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-06-15T12:53:56.928073Z","caller":"traceutil/trace.go:171","msg":"trace[1741130089] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-13ed4a89-b306-4e6b-836a-7aa13aacc056; range_end:; response_count:1; response_revision:5485; }","duration":"597.157523ms","start":"2026-06-15T12:53:56.330889Z","end":"2026-06-15T12:53:56.928046Z","steps":["trace[1741130089] 'agreement among raft nodes before linearized reading'  (duration: 596.872436ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T12:53:56.928115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.671632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-13ed4a89-b306-4e6b-836a-7aa13aacc056\" ","response":"range_response_count:1 size:3646"}
{"level":"warn","ts":"2026-06-15T12:53:56.928132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:53:56.330876Z","time spent":"597.240205ms","remote":"127.0.0.1:56436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3670,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-13ed4a89-b306-4e6b-836a-7aa13aacc056\" "}
{"level":"info","ts":"2026-06-15T12:53:56.928145Z","caller":"traceutil/trace.go:171","msg":"trace[2000332434] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-13ed4a89-b306-4e6b-836a-7aa13aacc056; range_end:; response_count:1; response_revision:5485; }","duration":"300.699692ms","start":"2026-06-15T12:53:56.627435Z","end":"2026-06-15T12:53:56.928135Z","steps":["trace[2000332434] 'agreement among raft nodes before linearized reading'  (duration: 300.61492ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T12:53:56.928181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:53:56.627352Z","time spent":"300.821955ms","remote":"127.0.0.1:56436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3670,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-13ed4a89-b306-4e6b-836a-7aa13aacc056\" "}
{"level":"info","ts":"2026-06-15T12:54:37.258212Z","caller":"traceutil/trace.go:171","msg":"trace[1535035752] transaction","detail":"{read_only:false; response_revision:5925; number_of_response:1; }","duration":"101.624345ms","start":"2026-06-15T12:54:37.156543Z","end":"2026-06-15T12:54:37.258167Z","steps":["trace[1535035752] 'process raft request'  (duration: 61.585445ms)","trace[1535035752] 'compare'  (duration: 39.469206ms)"],"step_count":2}
{"level":"info","ts":"2026-06-15T12:54:57.807239Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3000}
{"level":"info","ts":"2026-06-15T12:54:58.043601Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3000,"took":"234.887857ms","hash":3097590222,"current-db-size-bytes":57733120,"current-db-size":"58 MB","current-db-size-in-use-bytes":34115584,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-06-15T12:54:58.043695Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3097590222,"revision":3000,"compact-revision":-1}
{"level":"warn","ts":"2026-06-15T12:59:07.392045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.236744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-06-15T12:59:07.39227Z","caller":"traceutil/trace.go:171","msg":"trace[199721925] range","detail":"{range_begin:/registry/monitoring.coreos.com/servicemonitors/; range_end:/registry/monitoring.coreos.com/servicemonitors0; response_count:0; response_revision:7828; }","duration":"615.533211ms","start":"2026-06-15T12:59:06.776722Z","end":"2026-06-15T12:59:07.392256Z","steps":["trace[199721925] 'count revisions from in-memory index tree'  (duration: 615.10714ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T12:59:07.392326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:59:06.776701Z","time spent":"615.615233ms","remote":"127.0.0.1:51898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":23,"response size":31,"request content":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true "}
{"level":"info","ts":"2026-06-15T12:59:57.814509Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6078}
{"level":"info","ts":"2026-06-15T12:59:57.916001Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6078,"took":"98.706725ms","hash":3064012793,"current-db-size-bytes":57733120,"current-db-size":"58 MB","current-db-size-in-use-bytes":21434368,"current-db-size-in-use":"21 MB"}
{"level":"info","ts":"2026-06-15T12:59:57.91608Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3064012793,"revision":6078,"compact-revision":3000}
{"level":"info","ts":"2026-06-15T13:00:03.181437Z","caller":"traceutil/trace.go:171","msg":"trace[1726538667] linearizableReadLoop","detail":"{readStateIndex:8626; appliedIndex:8625; }","duration":"211.962714ms","start":"2026-06-15T13:00:02.969447Z","end":"2026-06-15T13:00:03.181409Z","steps":["trace[1726538667] 'read index received'  (duration: 211.77537ms)","trace[1726538667] 'applied index is now lower than readState.Index'  (duration: 185.274µs)"],"step_count":2}
{"level":"info","ts":"2026-06-15T13:00:03.181485Z","caller":"traceutil/trace.go:171","msg":"trace[1959017318] transaction","detail":"{read_only:false; response_revision:8326; number_of_response:1; }","duration":"229.394027ms","start":"2026-06-15T13:00:02.952056Z","end":"2026-06-15T13:00:03.18145Z","steps":["trace[1959017318] 'process raft request'  (duration: 229.185882ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T13:00:03.181762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.297513ms","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-06-15T13:00:03.181843Z","caller":"traceutil/trace.go:171","msg":"trace[203282803] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8326; }","duration":"212.444386ms","start":"2026-06-15T13:00:02.969378Z","end":"2026-06-15T13:00:03.181822Z","steps":["trace[203282803] 'agreement among raft nodes before linearized reading'  (duration: 212.16658ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T13:00:03.182526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.53409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-06-15T13:00:03.182596Z","caller":"traceutil/trace.go:171","msg":"trace[529587931] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8326; }","duration":"136.829217ms","start":"2026-06-15T13:00:03.045744Z","end":"2026-06-15T13:00:03.182573Z","steps":["trace[529587931] 'agreement among raft nodes before linearized reading'  (duration: 135.972747ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T13:00:03.474121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.908131ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976533089653490148 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:8315 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-06-15T13:00:03.47427Z","caller":"traceutil/trace.go:171","msg":"trace[64267216] transaction","detail":"{read_only:false; response_revision:8327; number_of_response:1; }","duration":"288.557177ms","start":"2026-06-15T13:00:03.185684Z","end":"2026-06-15T13:00:03.474241Z","steps":["trace[64267216] 'process raft request'  (duration: 186.435801ms)","trace[64267216] 'compare'  (duration: 101.776508ms)"],"step_count":2}
{"level":"info","ts":"2026-06-15T13:00:03.482572Z","caller":"traceutil/trace.go:171","msg":"trace[1922415458] linearizableReadLoop","detail":"{readStateIndex:8628; appliedIndex:8626; }","duration":"273.140901ms","start":"2026-06-15T13:00:03.209405Z","end":"2026-06-15T13:00:03.482546Z","steps":["trace[1922415458] 'read index received'  (duration: 162.706199ms)","trace[1922415458] 'applied index is now lower than readState.Index'  (duration: 110.433542ms)"],"step_count":2}
{"level":"info","ts":"2026-06-15T13:00:03.482713Z","caller":"traceutil/trace.go:171","msg":"trace[3260896] transaction","detail":"{read_only:false; response_revision:8328; number_of_response:1; }","duration":"295.334047ms","start":"2026-06-15T13:00:03.18733Z","end":"2026-06-15T13:00:03.482664Z","steps":["trace[3260896] 'process raft request'  (duration: 295.098122ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T13:00:03.482838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.429629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-06-15T13:00:03.483038Z","caller":"traceutil/trace.go:171","msg":"trace[1182505803] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8328; }","duration":"273.700355ms","start":"2026-06-15T13:00:03.209326Z","end":"2026-06-15T13:00:03.483026Z","steps":["trace[1182505803] 'agreement among raft nodes before linearized reading'  (duration: 273.331476ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T13:00:14.529872Z","caller":"traceutil/trace.go:171","msg":"trace[334279342] transaction","detail":"{read_only:false; response_revision:8386; number_of_response:1; }","duration":"203.719759ms","start":"2026-06-15T13:00:14.326098Z","end":"2026-06-15T13:00:14.529818Z","steps":["trace[334279342] 'process raft request'  (duration: 128.661723ms)","trace[334279342] 'compare'  (duration: 74.644236ms)"],"step_count":2}
{"level":"info","ts":"2026-06-15T13:00:16.514094Z","caller":"traceutil/trace.go:171","msg":"trace[1031171000] transaction","detail":"{read_only:false; response_revision:8395; number_of_response:1; }","duration":"156.904041ms","start":"2026-06-15T13:00:16.357147Z","end":"2026-06-15T13:00:16.514051Z","steps":["trace[1031171000] 'process raft request'  (duration: 98.314316ms)","trace[1031171000] 'compare'  (duration: 58.262328ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-15T13:00:17.876126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.130538ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976533089653490402 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:8392 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-06-15T13:00:17.876524Z","caller":"traceutil/trace.go:171","msg":"trace[1323032307] transaction","detail":"{read_only:false; response_revision:8402; number_of_response:1; }","duration":"296.969026ms","start":"2026-06-15T13:00:17.579528Z","end":"2026-06-15T13:00:17.876497Z","steps":["trace[1323032307] 'process raft request'  (duration: 296.747791ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T13:00:17.87653Z","caller":"traceutil/trace.go:171","msg":"trace[1449116243] transaction","detail":"{read_only:false; response_revision:8401; number_of_response:1; }","duration":"297.050078ms","start":"2026-06-15T13:00:17.579442Z","end":"2026-06-15T13:00:17.876492Z","steps":["trace[1449116243] 'process raft request'  (duration: 95.440048ms)","trace[1449116243] 'compare'  (duration: 200.971945ms)"],"step_count":2}
{"level":"info","ts":"2026-06-15T13:00:18.539206Z","caller":"traceutil/trace.go:171","msg":"trace[1184857138] transaction","detail":"{read_only:false; response_revision:8403; number_of_response:1; }","duration":"180.790767ms","start":"2026-06-15T13:00:18.358378Z","end":"2026-06-15T13:00:18.539169Z","steps":["trace[1184857138] 'process raft request'  (duration: 180.536901ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T13:00:43.081171Z","caller":"traceutil/trace.go:171","msg":"trace[2113759409] transaction","detail":"{read_only:false; response_revision:8592; number_of_response:1; }","duration":"212.733983ms","start":"2026-06-15T13:00:42.868412Z","end":"2026-06-15T13:00:43.081146Z","steps":["trace[2113759409] 'process raft request'  (duration: 212.531788ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T13:00:43.081565Z","caller":"traceutil/trace.go:171","msg":"trace[1764741570] linearizableReadLoop","detail":"{readStateIndex:8902; appliedIndex:8902; }","duration":"187.501606ms","start":"2026-06-15T13:00:42.894Z","end":"2026-06-15T13:00:43.081502Z","steps":["trace[1764741570] 'read index received'  (duration: 187.480276ms)","trace[1764741570] 'applied index is now lower than readState.Index'  (duration: 16.91µs)"],"step_count":2}
{"level":"warn","ts":"2026-06-15T13:00:43.081803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.788093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-15T13:00:43.081854Z","caller":"traceutil/trace.go:171","msg":"trace[2145642444] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8592; }","duration":"187.890915ms","start":"2026-06-15T13:00:42.893951Z","end":"2026-06-15T13:00:43.081842Z","steps":["trace[2145642444] 'agreement among raft nodes before linearized reading'  (duration: 187.806463ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T13:00:46.049956Z","caller":"traceutil/trace.go:171","msg":"trace[1002461608] transaction","detail":"{read_only:false; response_revision:8606; number_of_response:1; }","duration":"320.801607ms","start":"2026-06-15T13:00:45.729128Z","end":"2026-06-15T13:00:46.04993Z","steps":["trace[1002461608] 'process raft request'  (duration: 320.649933ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T13:00:46.050109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T13:00:45.729111Z","time spent":"320.92235ms","remote":"127.0.0.1:56500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:8597 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-06-15T13:00:46.341859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.104858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-15T13:00:46.341958Z","caller":"traceutil/trace.go:171","msg":"trace[281834617] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:8606; }","duration":"210.264902ms","start":"2026-06-15T13:00:46.131671Z","end":"2026-06-15T13:00:46.341936Z","steps":["trace[281834617] 'count revisions from in-memory index tree'  (duration: 210.013956ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T13:00:46.342029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.40566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-06-15T13:00:46.342116Z","caller":"traceutil/trace.go:171","msg":"trace[1500597930] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8606; }","duration":"275.569125ms","start":"2026-06-15T13:00:46.066525Z","end":"2026-06-15T13:00:46.342094Z","steps":["trace[1500597930] 'range keys from in-memory index tree'  (duration: 275.192215ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T13:00:46.342121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.92822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-qzzrl\" ","response":"range_response_count:1 size:6445"}
{"level":"info","ts":"2026-06-15T13:00:46.34228Z","caller":"traceutil/trace.go:171","msg":"trace[1641345495] range","detail":"{range_begin:/registry/pods/openstack/keepalived-qzzrl; range_end:; response_count:1; response_revision:8606; }","duration":"270.130824ms","start":"2026-06-15T13:00:46.072115Z","end":"2026-06-15T13:00:46.342246Z","steps":["trace[1641345495] 'range keys from in-memory index tree'  (duration: 269.811167ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T13:00:46.34249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.228222ms","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-06-15T13:00:46.342618Z","caller":"traceutil/trace.go:171","msg":"trace[1696430121] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8606; }","duration":"279.400796ms","start":"2026-06-15T13:00:46.063169Z","end":"2026-06-15T13:00:46.34257Z","steps":["trace[1696430121] 'range keys from in-memory index tree'  (duration: 278.986457ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T13:00:46.399945Z","caller":"traceutil/trace.go:171","msg":"trace[1074519705] linearizableReadLoop","detail":"{readStateIndex:8917; appliedIndex:8916; }","duration":"112.854791ms","start":"2026-06-15T13:00:46.287076Z","end":"2026-06-15T13:00:46.399931Z","steps":["trace[1074519705] 'read index received'  (duration: 112.735758ms)","trace[1074519705] 'applied index is now lower than readState.Index'  (duration: 118.143µs)"],"step_count":2}
{"level":"warn","ts":"2026-06-15T13:00:46.400073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.981724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-15T13:00:46.400039Z","caller":"traceutil/trace.go:171","msg":"trace[1870685092] transaction","detail":"{read_only:false; response_revision:8607; number_of_response:1; }","duration":"169.061055ms","start":"2026-06-15T13:00:46.230931Z","end":"2026-06-15T13:00:46.399992Z","steps":["trace[1870685092] 'process raft request'  (duration: 168.876721ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T13:00:46.400099Z","caller":"traceutil/trace.go:171","msg":"trace[326900165] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:8607; }","duration":"113.060426ms","start":"2026-06-15T13:00:46.287031Z","end":"2026-06-15T13:00:46.400091Z","steps":["trace[326900165] 'agreement among raft nodes before linearized reading'  (duration: 112.972513ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T13:00:50.241116Z","caller":"traceutil/trace.go:171","msg":"trace[1687531056] transaction","detail":"{read_only:false; response_revision:8627; number_of_response:1; }","duration":"172.154089ms","start":"2026-06-15T13:00:50.068934Z","end":"2026-06-15T13:00:50.241088Z","steps":["trace[1687531056] 'process raft request'  (duration: 171.985545ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T13:00:50.569997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.270107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-06-15T13:00:50.570091Z","caller":"traceutil/trace.go:171","msg":"trace[1033435859] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8627; }","duration":"135.39839ms","start":"2026-06-15T13:00:50.434671Z","end":"2026-06-15T13:00:50.570069Z","steps":["trace[1033435859] 'range keys from in-memory index tree'  (duration: 135.111083ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T13:00:50.570171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.890705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-qzzrl\" ","response":"range_response_count:1 size:6445"}
{"level":"warn","ts":"2026-06-15T13:00:50.570209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.406728ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-15T13:00:50.570254Z","caller":"traceutil/trace.go:171","msg":"trace[892858747] range","detail":"{range_begin:/registry/pods/openstack/keepalived-qzzrl; range_end:; response_count:1; response_revision:8627; }","duration":"134.014897ms","start":"2026-06-15T13:00:50.436216Z","end":"2026-06-15T13:00:50.570231Z","steps":["trace[892858747] 'range keys from in-memory index tree'  (duration: 133.761771ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T13:00:50.570273Z","caller":"traceutil/trace.go:171","msg":"trace[2002219693] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:8627; }","duration":"198.47208ms","start":"2026-06-15T13:00:50.371789Z","end":"2026-06-15T13:00:50.570261Z","steps":["trace[2002219693] 'range keys from in-memory index tree'  (duration: 198.393258ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T13:00:50.570324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.726445ms","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-06-15T13:00:50.57042Z","caller":"traceutil/trace.go:171","msg":"trace[1298741537] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8627; }","duration":"142.865709ms","start":"2026-06-15T13:00:50.427531Z","end":"2026-06-15T13:00:50.570397Z","steps":["trace[1298741537] 'range keys from in-memory index tree'  (duration: 142.51987ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T13:00:58.506213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.47467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-6r9cx\" ","response":"range_response_count:1 size:4648"}
{"level":"info","ts":"2026-06-15T13:00:58.506313Z","caller":"traceutil/trace.go:171","msg":"trace[684013769] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-6r9cx; range_end:; response_count:1; response_revision:8713; }","duration":"119.637563ms","start":"2026-06-15T13:00:58.386657Z","end":"2026-06-15T13:00:58.506294Z","steps":["trace[684013769] 'range keys from in-memory index tree'  (duration: 119.277905ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T13:00:58.677594Z","caller":"traceutil/trace.go:171","msg":"trace[2088150022] transaction","detail":"{read_only:false; response_revision:8714; number_of_response:1; }","duration":"289.899618ms","start":"2026-06-15T13:00:58.387668Z","end":"2026-06-15T13:00:58.677567Z","steps":["trace[2088150022] 'process raft request'  (duration: 289.734024ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T13:00:58.891463Z","caller":"traceutil/trace.go:171","msg":"trace[631068002] linearizableReadLoop","detail":"{readStateIndex:9032; appliedIndex:9030; }","duration":"273.70502ms","start":"2026-06-15T13:00:58.617722Z","end":"2026-06-15T13:00:58.891427Z","steps":["trace[631068002] 'read index received'  (duration: 59.728309ms)","trace[631068002] 'applied index is now lower than readState.Index'  (duration: 213.97464ms)"],"step_count":2}
{"level":"info","ts":"2026-06-15T13:00:58.89159Z","caller":"traceutil/trace.go:171","msg":"trace[803999142] transaction","detail":"{read_only:false; response_revision:8715; number_of_response:1; }","duration":"376.037568ms","start":"2026-06-15T13:00:58.515508Z","end":"2026-06-15T13:00:58.891545Z","steps":["trace[803999142] 'process raft request'  (duration: 375.67373ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T13:00:58.891742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.984816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-qzzrl\" ","response":"range_response_count:1 size:6445"}
{"level":"info","ts":"2026-06-15T13:00:58.891798Z","caller":"traceutil/trace.go:171","msg":"trace[1274779667] range","detail":"{range_begin:/registry/pods/openstack/keepalived-qzzrl; range_end:; response_count:1; response_revision:8715; }","duration":"274.110319ms","start":"2026-06-15T13:00:58.617674Z","end":"2026-06-15T13:00:58.891785Z","steps":["trace[1274779667] 'agreement among raft nodes before linearized reading'  (duration: 273.937295ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T13:00:58.891845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T13:00:58.51548Z","time spent":"376.265684ms","remote":"127.0.0.1:56436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4638,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/rook-ceph-detect-version-6r9cx\" mod_revision:8712 > success:<request_put:<key:\"/registry/pods/openstack/rook-ceph-detect-version-6r9cx\" value_size:4575 >> failure:<request_range:<key:\"/registry/pods/openstack/rook-ceph-detect-version-6r9cx\" > >"}
{"level":"info","ts":"2026-06-15T13:00:58.901182Z","caller":"traceutil/trace.go:171","msg":"trace[449275156] transaction","detail":"{read_only:false; response_revision:8716; number_of_response:1; }","duration":"177.571239ms","start":"2026-06-15T13:00:58.723584Z","end":"2026-06-15T13:00:58.901155Z","steps":["trace[449275156] 'process raft request'  (duration: 177.096768ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T13:00:58.901691Z","caller":"traceutil/trace.go:171","msg":"trace[521943524] transaction","detail":"{read_only:false; response_revision:8717; number_of_response:1; }","duration":"162.089539ms","start":"2026-06-15T13:00:58.739588Z","end":"2026-06-15T13:00:58.901677Z","steps":["trace[521943524] 'process raft request'  (duration: 161.224008ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T13:00:58.902498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.017579ms","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-06-15T13:00:58.902567Z","caller":"traceutil/trace.go:171","msg":"trace[310708537] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8718; }","duration":"249.129732ms","start":"2026-06-15T13:00:58.653422Z","end":"2026-06-15T13:00:58.902552Z","steps":["trace[310708537] 'agreement among raft nodes before linearized reading'  (duration: 248.832785ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T13:00:58.902584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.163331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-06-15T13:00:58.902689Z","caller":"traceutil/trace.go:171","msg":"trace[537846800] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8718; }","duration":"264.316205ms","start":"2026-06-15T13:00:58.638346Z","end":"2026-06-15T13:00:58.902662Z","steps":["trace[537846800] 'agreement among raft nodes before linearized reading'  (duration: 263.932156ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T13:00:59.303759Z","caller":"traceutil/trace.go:171","msg":"trace[1103924904] linearizableReadLoop","detail":"{readStateIndex:9039; appliedIndex:9038; }","duration":"137.8974ms","start":"2026-06-15T13:00:59.165835Z","end":"2026-06-15T13:00:59.303733Z","steps":["trace[1103924904] 'read index received'  (duration: 58.013798ms)","trace[1103924904] 'applied index is now lower than readState.Index'  (duration: 79.882572ms)"],"step_count":2}
{"level":"info","ts":"2026-06-15T13:00:59.303841Z","caller":"traceutil/trace.go:171","msg":"trace[1484138758] transaction","detail":"{read_only:false; response_revision:8722; number_of_response:1; }","duration":"142.50197ms","start":"2026-06-15T13:00:59.161282Z","end":"2026-06-15T13:00:59.303784Z","steps":["trace[1484138758] 'process raft request'  (duration: 62.551887ms)","trace[1484138758] 'compare'  (duration: 79.755909ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-15T13:00:59.304152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.295349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-06-15T13:00:59.304209Z","caller":"traceutil/trace.go:171","msg":"trace[644323322] range","detail":"{range_begin:/registry/monitoring.coreos.com/servicemonitors/; range_end:/registry/monitoring.coreos.com/servicemonitors0; response_count:0; response_revision:8722; }","duration":"138.416872ms","start":"2026-06-15T13:00:59.165778Z","end":"2026-06-15T13:00:59.304195Z","steps":["trace[644323322] 'agreement among raft nodes before linearized reading'  (duration: 138.052023ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T13:00:59.375966Z","caller":"traceutil/trace.go:171","msg":"trace[1770098974] transaction","detail":"{read_only:false; response_revision:8723; number_of_response:1; }","duration":"189.803102ms","start":"2026-06-15T13:00:59.186129Z","end":"2026-06-15T13:00:59.375932Z","steps":["trace[1770098974] 'process raft request'  (duration: 189.644108ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T13:00:59.798925Z","caller":"traceutil/trace.go:171","msg":"trace[2131716956] linearizableReadLoop","detail":"{readStateIndex:9041; appliedIndex:9040; }","duration":"219.444841ms","start":"2026-06-15T13:00:59.579451Z","end":"2026-06-15T13:00:59.798896Z","steps":["trace[2131716956] 'read index received'  (duration: 219.205676ms)","trace[2131716956] 'applied index is now lower than readState.Index'  (duration: 238.055µs)"],"step_count":2}
{"level":"info","ts":"2026-06-15T13:00:59.798976Z","caller":"traceutil/trace.go:171","msg":"trace[301109438] transaction","detail":"{read_only:false; response_revision:8724; number_of_response:1; }","duration":"220.785403ms","start":"2026-06-15T13:00:59.578144Z","end":"2026-06-15T13:00:59.798929Z","steps":["trace[301109438] 'process raft request'  (duration: 220.595079ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T13:00:59.799231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.704347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-06-15T13:00:59.799321Z","caller":"traceutil/trace.go:171","msg":"trace[574641182] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:8724; }","duration":"219.876672ms","start":"2026-06-15T13:00:59.579428Z","end":"2026-06-15T13:00:59.799305Z","steps":["trace[574641182] 'agreement among raft nodes before linearized reading'  (duration: 219.600806ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T13:00:59.7993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.114301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5732"}
{"level":"info","ts":"2026-06-15T13:00:59.799389Z","caller":"traceutil/trace.go:171","msg":"trace[1907736410] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8724; }","duration":"193.240264ms","start":"2026-06-15T13:00:59.606126Z","end":"2026-06-15T13:00:59.799366Z","steps":["trace[1907736410] 'agreement among raft nodes before linearized reading'  (duration: 192.986518ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T13:01:00.25753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.826524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-06-15T13:01:00.2576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.916689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-06-15T13:01:00.257637Z","caller":"traceutil/trace.go:171","msg":"trace[2108910314] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:8726; }","duration":"258.950367ms","start":"2026-06-15T13:00:59.998662Z","end":"2026-06-15T13:01:00.257613Z","steps":["trace[2108910314] 'count revisions from in-memory index tree'  (duration: 258.737401ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T13:01:00.257679Z","caller":"traceutil/trace.go:171","msg":"trace[836154774] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:8726; }","duration":"232.048233ms","start":"2026-06-15T13:01:00.025609Z","end":"2026-06-15T13:01:00.257657Z","steps":["trace[836154774] 'count revisions from in-memory index tree'  (duration: 231.836738ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T13:01:00.257601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.560645ms","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-06-15T13:01:00.257832Z","caller":"traceutil/trace.go:171","msg":"trace[1721936321] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:8726; }","duration":"255.831812ms","start":"2026-06-15T13:01:00.001981Z","end":"2026-06-15T13:01:00.257812Z","steps":["trace[1721936321] 'count revisions from in-memory index tree'  (duration: 255.504234ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T13:01:00.258158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.108714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-06-15T13:01:00.258402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.681794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2224963"}
{"level":"info","ts":"2026-06-15T13:01:00.258487Z","caller":"traceutil/trace.go:171","msg":"trace[911663647] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:8726; }","duration":"119.810357ms","start":"2026-06-15T13:01:00.138658Z","end":"2026-06-15T13:01:00.258469Z","steps":["trace[911663647] 'range keys from in-memory index tree'  (duration: 118.761062ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T13:01:00.258228Z","caller":"traceutil/trace.go:171","msg":"trace[2045191823] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8726; }","duration":"270.222277ms","start":"2026-06-15T13:00:59.987988Z","end":"2026-06-15T13:01:00.258211Z","steps":["trace[2045191823] 'count revisions from in-memory index tree'  (duration: 270.029992ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T13:01:00.550417Z","caller":"traceutil/trace.go:171","msg":"trace[520093672] transaction","detail":"{read_only:false; response_revision:8728; number_of_response:1; }","duration":"131.178869ms","start":"2026-06-15T13:01:00.419206Z","end":"2026-06-15T13:01:00.550385Z","steps":["trace[520093672] 'process raft request'  (duration: 95.918425ms)","trace[520093672] 'compare'  (duration: 35.060569ms)"],"step_count":2}
{"level":"info","ts":"2026-06-15T13:01:17.603712Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002403.wal"}
{"level":"warn","ts":"2026-06-15T13:02:17.087808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.602938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-15T13:02:17.087953Z","caller":"traceutil/trace.go:171","msg":"trace[298684789] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:9476; }","duration":"113.813973ms","start":"2026-06-15T13:02:16.974105Z","end":"2026-06-15T13:02:17.087919Z","steps":["trace[298684789] 'count revisions from in-memory index tree'  (duration: 113.448685ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T13:02:17.365261Z","caller":"traceutil/trace.go:171","msg":"trace[624185356] transaction","detail":"{read_only:false; response_revision:9478; number_of_response:1; }","duration":"178.233185ms","start":"2026-06-15T13:02:17.186994Z","end":"2026-06-15T13:02:17.365227Z","steps":["trace[624185356] 'process raft request'  (duration: 113.709331ms)","trace[624185356] 'compare'  (duration: 64.163266ms)"],"step_count":2}
{"level":"info","ts":"2026-06-15T13:02:17.365372Z","caller":"traceutil/trace.go:171","msg":"trace[838653223] transaction","detail":"{read_only:false; response_revision:9479; number_of_response:1; }","duration":"176.651437ms","start":"2026-06-15T13:02:17.188658Z","end":"2026-06-15T13:02:17.36531Z","steps":["trace[838653223] 'process raft request'  (duration: 176.365841ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T13:02:17.640999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.970518ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976533089653493470 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:9472 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-06-15T13:02:17.641434Z","caller":"traceutil/trace.go:171","msg":"trace[2142109061] transaction","detail":"{read_only:false; response_revision:9481; number_of_response:1; }","duration":"270.612096ms","start":"2026-06-15T13:02:17.370775Z","end":"2026-06-15T13:02:17.641387Z","steps":["trace[2142109061] 'process raft request'  (duration: 133.144936ms)","trace[2142109061] 'compare'  (duration: 136.773053ms)"],"step_count":2}
{"level":"info","ts":"2026-06-15T13:02:17.641557Z","caller":"traceutil/trace.go:171","msg":"trace[89675627] transaction","detail":"{read_only:false; response_revision:9482; number_of_response:1; }","duration":"270.571285ms","start":"2026-06-15T13:02:17.370956Z","end":"2026-06-15T13:02:17.641527Z","steps":["trace[89675627] 'process raft request'  (duration: 270.35357ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T13:02:17.641633Z","caller":"traceutil/trace.go:171","msg":"trace[1856092246] linearizableReadLoop","detail":"{readStateIndex:9821; appliedIndex:9818; }","duration":"269.921409ms","start":"2026-06-15T13:02:17.37169Z","end":"2026-06-15T13:02:17.641612Z","steps":["trace[1856092246] 'read index received'  (duration: 70.944708ms)","trace[1856092246] 'applied index is now lower than readState.Index'  (duration: 198.974431ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-15T13:02:17.641853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.131254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-qzzrl\" ","response":"range_response_count:1 size:6445"}
{"level":"info","ts":"2026-06-15T13:02:17.641969Z","caller":"traceutil/trace.go:171","msg":"trace[558250125] range","detail":"{range_begin:/registry/pods/openstack/keepalived-qzzrl; range_end:; response_count:1; response_revision:9482; }","duration":"270.266358ms","start":"2026-06-15T13:02:17.371673Z","end":"2026-06-15T13:02:17.641939Z","steps":["trace[558250125] 'agreement among raft nodes before linearized reading'  (duration: 270.043313ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-15T13:02:17.642448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.45339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-15T13:02:17.642519Z","caller":"traceutil/trace.go:171","msg":"trace[1099979218] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9483; }","duration":"122.524392ms","start":"2026-06-15T13:02:17.519979Z","end":"2026-06-15T13:02:17.642503Z","steps":["trace[1099979218] 'agreement among raft nodes before linearized reading'  (duration: 122.218514ms)"],"step_count":1}
{"level":"info","ts":"2026-06-15T13:02:39.716724Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d7dbc9f5893cc1f6","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-06-15T13:02:39.722073Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-06-15T13:02:39.722169Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-06-15T13:04:57.821352Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8168}
{"level":"info","ts":"2026-06-15T13:04:57.886629Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8168,"took":"63.199394ms","hash":752754924,"current-db-size-bytes":57733120,"current-db-size":"58 MB","current-db-size-in-use-bytes":29442048,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-06-15T13:04:57.886683Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":752754924,"revision":8168,"compact-revision":6078}