{"level":"warn","ts":"2026-03-11T19:28:56.540337Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-11T19:28:56.540423Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.115:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.115:2380","--initial-cluster=instance=https://199.204.45.115:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.115:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.115:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-03-11T19:28:56.540488Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-11T19:28:56.540503Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.115:2380"]}
{"level":"info","ts":"2026-03-11T19:28:56.540521Z","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-03-11T19:28:56.541319Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"]}
{"level":"info","ts":"2026-03-11T19:28:56.541397Z","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.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.115:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-03-11T19:28:56.545401Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.785095ms"}
{"level":"info","ts":"2026-03-11T19:28:56.552343Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e3aaa5c123e150e0","cluster-id":"61ec519698823541"}
{"level":"info","ts":"2026-03-11T19:28:56.552428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-11T19:28:56.55245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 0"}
{"level":"info","ts":"2026-03-11T19:28:56.552466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e3aaa5c123e150e0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-11T19:28:56.552483Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 1"}
{"level":"info","ts":"2026-03-11T19:28:56.552518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"}
{"level":"warn","ts":"2026-03-11T19:28:56.557853Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-11T19:28:56.55951Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-11T19:28:56.560737Z","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-03-11T19:28:56.563445Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e3aaa5c123e150e0","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-11T19:28:56.563753Z","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-03-11T19:28:56.563895Z","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-03-11T19:28:56.563919Z","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-03-11T19:28:56.563764Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e3aaa5c123e150e0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-11T19:28:56.566718Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"}
{"level":"info","ts":"2026-03-11T19:28:56.567373Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","added-peer-id":"e3aaa5c123e150e0","added-peer-peer-urls":["https://199.204.45.115:2380"]}
{"level":"info","ts":"2026-03-11T19:28:56.570718Z","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-03-11T19:28:56.570831Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.115:2380"}
{"level":"info","ts":"2026-03-11T19:28:56.5709Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.115:2380"}
{"level":"info","ts":"2026-03-11T19:28:56.571328Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e3aaa5c123e150e0","initial-advertise-peer-urls":["https://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-11T19:28:56.571372Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-11T19:28:56.753642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-11T19:28:56.753686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-11T19:28:56.753724Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgPreVoteResp from e3aaa5c123e150e0 at term 1"}
{"level":"info","ts":"2026-03-11T19:28:56.753745Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became candidate at term 2"}
{"level":"info","ts":"2026-03-11T19:28:56.753758Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgVoteResp from e3aaa5c123e150e0 at term 2"}
{"level":"info","ts":"2026-03-11T19:28:56.753777Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became leader at term 2"}
{"level":"info","ts":"2026-03-11T19:28:56.753805Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e3aaa5c123e150e0 elected leader e3aaa5c123e150e0 at term 2"}
{"level":"info","ts":"2026-03-11T19:28:56.754885Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-11T19:28:56.75604Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e3aaa5c123e150e0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.115:2379]}","request-path":"/0/members/e3aaa5c123e150e0/attributes","cluster-id":"61ec519698823541","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-11T19:28:56.756108Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-11T19:28:56.756166Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-11T19:28:56.756499Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-11T19:28:56.756546Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-11T19:28:56.756597Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-11T19:28:56.756663Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-11T19:28:56.756683Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-11T19:28:56.759556Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.115:2379"}
{"level":"info","ts":"2026-03-11T19:28:56.762104Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-03-11T19:29:03.499313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.735742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-03-11T19:29:03.499423Z","caller":"traceutil/trace.go:171","msg":"trace[724031210] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:318; }","duration":"160.890045ms","start":"2026-03-11T19:29:03.338516Z","end":"2026-03-11T19:29:03.499406Z","steps":["trace[724031210] 'range keys from in-memory index tree'  (duration: 160.647229ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:29:26.574246Z","caller":"traceutil/trace.go:171","msg":"trace[1208524952] linearizableReadLoop","detail":"{readStateIndex:529; appliedIndex:528; }","duration":"100.19388ms","start":"2026-03-11T19:29:26.474026Z","end":"2026-03-11T19:29:26.57422Z","steps":["trace[1208524952] 'read index received'  (duration: 99.941804ms)","trace[1208524952] 'applied index is now lower than readState.Index'  (duration: 251.316µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T19:29:26.574419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.363413ms","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-03-11T19:29:26.574498Z","caller":"traceutil/trace.go:171","msg":"trace[1147920533] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"101.215712ms","start":"2026-03-11T19:29:26.473058Z","end":"2026-03-11T19:29:26.574274Z","steps":["trace[1147920533] 'process raft request'  (duration: 100.998987ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:29:26.574448Z","caller":"traceutil/trace.go:171","msg":"trace[1611711406] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:513; }","duration":"100.421434ms","start":"2026-03-11T19:29:26.474018Z","end":"2026-03-11T19:29:26.574439Z","steps":["trace[1611711406] 'agreement among raft nodes before linearized reading'  (duration: 100.302872ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:29:32.846446Z","caller":"traceutil/trace.go:171","msg":"trace[1308869756] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:570; }","duration":"235.120774ms","start":"2026-03-11T19:29:32.611298Z","end":"2026-03-11T19:29:32.846419Z","steps":["trace[1308869756] 'read index received'  (duration: 234.860258ms)","trace[1308869756] 'applied index is now lower than readState.Index'  (duration: 259.316µs)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:29:32.846557Z","caller":"traceutil/trace.go:171","msg":"trace[1235590238] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"241.069957ms","start":"2026-03-11T19:29:32.605458Z","end":"2026-03-11T19:29:32.846528Z","steps":["trace[1235590238] 'process raft request'  (duration: 240.773591ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:29:32.846758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.441742ms","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-03-11T19:29:32.846815Z","caller":"traceutil/trace.go:171","msg":"trace[280018789] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:554; }","duration":"235.561885ms","start":"2026-03-11T19:29:32.611242Z","end":"2026-03-11T19:29:32.846804Z","steps":["trace[280018789] 'agreement among raft nodes before linearized reading'  (duration: 235.36867ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:29:32.846974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.011176ms","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-03-11T19:29:32.847093Z","caller":"traceutil/trace.go:171","msg":"trace[2070752759] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:554; }","duration":"232.160578ms","start":"2026-03-11T19:29:32.614911Z","end":"2026-03-11T19:29:32.847072Z","steps":["trace[2070752759] 'agreement among raft nodes before linearized reading'  (duration: 231.826711ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:29:33.152578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.011575ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827830396718869682 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:548 > 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-03-11T19:29:33.152687Z","caller":"traceutil/trace.go:171","msg":"trace[368002539] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"300.804351ms","start":"2026-03-11T19:29:32.851866Z","end":"2026-03-11T19:29:33.15267Z","steps":["trace[368002539] 'process raft request'  (duration: 153.04992ms)","trace[368002539] 'compare'  (duration: 146.836901ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T19:29:33.15275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T19:29:32.851854Z","time spent":"300.868103ms","remote":"127.0.0.1:41748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:548 > 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-03-11T19:29:33.161148Z","caller":"traceutil/trace.go:171","msg":"trace[1592725471] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"309.024975ms","start":"2026-03-11T19:29:32.852097Z","end":"2026-03-11T19:29:33.161122Z","steps":["trace[1592725471] 'process raft request'  (duration: 308.816391ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:29:33.161308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T19:29:32.852075Z","time spent":"309.157199ms","remote":"127.0.0.1:41748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:547 > 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":"info","ts":"2026-03-11T19:29:33.161354Z","caller":"traceutil/trace.go:171","msg":"trace[1441838673] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"302.0628ms","start":"2026-03-11T19:29:32.859261Z","end":"2026-03-11T19:29:33.161324Z","steps":["trace[1441838673] 'process raft request'  (duration: 301.796164ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:29:33.161447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T19:29:32.859223Z","time spent":"302.177561ms","remote":"127.0.0.1:41670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-h8mjw\" mod_revision:506 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-h8mjw\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-h8mjw\" > >"}
{"level":"info","ts":"2026-03-11T19:29:54.100185Z","caller":"traceutil/trace.go:171","msg":"trace[1609454527] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"113.898245ms","start":"2026-03-11T19:29:53.986263Z","end":"2026-03-11T19:29:54.100161Z","steps":["trace[1609454527] 'process raft request'  (duration: 94.918637ms)","trace[1609454527] 'compare'  (duration: 18.895396ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T19:30:41.693672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.707425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-11T19:30:41.693768Z","caller":"traceutil/trace.go:171","msg":"trace[1706768921] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:1594; }","duration":"115.855019ms","start":"2026-03-11T19:30:41.577893Z","end":"2026-03-11T19:30:41.693748Z","steps":["trace[1706768921] 'count revisions from in-memory index tree'  (duration: 115.638294ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:30:42.06499Z","caller":"traceutil/trace.go:171","msg":"trace[969852927] transaction","detail":"{read_only:false; response_revision:1596; number_of_response:1; }","duration":"120.190777ms","start":"2026-03-11T19:30:41.944769Z","end":"2026-03-11T19:30:42.06496Z","steps":["trace[969852927] 'process raft request'  (duration: 120.025494ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:31:31.61984Z","caller":"traceutil/trace.go:171","msg":"trace[1443232990] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"124.208547ms","start":"2026-03-11T19:31:31.495607Z","end":"2026-03-11T19:31:31.619815Z","steps":["trace[1443232990] 'process raft request'  (duration: 124.111495ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:31:32.333897Z","caller":"traceutil/trace.go:171","msg":"trace[453234652] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"115.247444ms","start":"2026-03-11T19:31:32.21862Z","end":"2026-03-11T19:31:32.333868Z","steps":["trace[453234652] 'process raft request'  (duration: 115.098951ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:31:32.451072Z","caller":"traceutil/trace.go:171","msg":"trace[70179643] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"224.987603ms","start":"2026-03-11T19:31:32.226047Z","end":"2026-03-11T19:31:32.451035Z","steps":["trace[70179643] 'process raft request'  (duration: 142.602935ms)","trace[70179643] 'compare'  (duration: 82.061931ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:31:37.967745Z","caller":"traceutil/trace.go:171","msg":"trace[2138527918] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"124.589215ms","start":"2026-03-11T19:31:37.843111Z","end":"2026-03-11T19:31:37.9677Z","steps":["trace[2138527918] 'process raft request'  (duration: 124.307209ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:31:37.968972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.413288ms","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-03-11T19:31:37.969093Z","caller":"traceutil/trace.go:171","msg":"trace[352439844] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1917; }","duration":"100.618973ms","start":"2026-03-11T19:31:37.86845Z","end":"2026-03-11T19:31:37.969069Z","steps":["trace[352439844] 'agreement among raft nodes before linearized reading'  (duration: 99.20026ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:31:38.326173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.643751ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827830396718872448 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1909 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-11T19:31:38.326497Z","caller":"traceutil/trace.go:171","msg":"trace[2011994282] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"352.959137ms","start":"2026-03-11T19:31:37.973473Z","end":"2026-03-11T19:31:38.326432Z","steps":["trace[2011994282] 'process raft request'  (duration: 352.821984ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:31:38.326525Z","caller":"traceutil/trace.go:171","msg":"trace[1781204372] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"354.342607ms","start":"2026-03-11T19:31:37.972143Z","end":"2026-03-11T19:31:38.326486Z","steps":["trace[1781204372] 'process raft request'  (duration: 194.262786ms)","trace[1781204372] 'compare'  (duration: 159.400956ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T19:31:38.326617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T19:31:37.973458Z","time spent":"353.12065ms","remote":"127.0.0.1:41748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1908 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-11T19:31:38.326728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T19:31:37.972124Z","time spent":"354.516811ms","remote":"127.0.0.1:41748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1909 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-03-11T19:31:38.657604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.996902ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827830396718872450 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1911 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-11T19:31:38.657688Z","caller":"traceutil/trace.go:171","msg":"trace[110004617] linearizableReadLoop","detail":"{readStateIndex:1994; appliedIndex:1993; }","duration":"252.685193ms","start":"2026-03-11T19:31:38.404991Z","end":"2026-03-11T19:31:38.657677Z","steps":["trace[110004617] 'read index received'  (duration: 76.528826ms)","trace[110004617] 'applied index is now lower than readState.Index'  (duration: 176.155427ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:31:38.657744Z","caller":"traceutil/trace.go:171","msg":"trace[1481432138] transaction","detail":"{read_only:false; response_revision:1920; number_of_response:1; }","duration":"300.978438ms","start":"2026-03-11T19:31:38.356749Z","end":"2026-03-11T19:31:38.657727Z","steps":["trace[1481432138] 'process raft request'  (duration: 124.791501ms)","trace[1481432138] 'compare'  (duration: 175.911611ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T19:31:38.657777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T19:31:38.356708Z","time spent":"301.05274ms","remote":"127.0.0.1:41748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1911 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-03-11T19:31:38.65797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.964789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-03-11T19:31:38.658069Z","caller":"traceutil/trace.go:171","msg":"trace[1006659077] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1920; }","duration":"253.112143ms","start":"2026-03-11T19:31:38.404932Z","end":"2026-03-11T19:31:38.658045Z","steps":["trace[1006659077] 'agreement among raft nodes before linearized reading'  (duration: 252.800056ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:31:38.665285Z","caller":"traceutil/trace.go:171","msg":"trace[427067406] transaction","detail":"{read_only:false; response_revision:1921; number_of_response:1; }","duration":"197.52723ms","start":"2026-03-11T19:31:38.467732Z","end":"2026-03-11T19:31:38.66526Z","steps":["trace[427067406] 'process raft request'  (duration: 197.300875ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:31:38.665328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.438264ms","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-03-11T19:31:38.665403Z","caller":"traceutil/trace.go:171","msg":"trace[1232487649] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1921; }","duration":"158.565877ms","start":"2026-03-11T19:31:38.506819Z","end":"2026-03-11T19:31:38.665384Z","steps":["trace[1232487649] 'agreement among raft nodes before linearized reading'  (duration: 158.346562ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:32:13.570181Z","caller":"traceutil/trace.go:171","msg":"trace[1137056518] linearizableReadLoop","detail":"{readStateIndex:2357; appliedIndex:2356; }","duration":"121.959896ms","start":"2026-03-11T19:32:13.448192Z","end":"2026-03-11T19:32:13.570151Z","steps":["trace[1137056518] 'read index received'  (duration: 121.739171ms)","trace[1137056518] 'applied index is now lower than readState.Index'  (duration: 219.485µs)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:32:13.570298Z","caller":"traceutil/trace.go:171","msg":"trace[1207421680] transaction","detail":"{read_only:false; response_revision:2268; number_of_response:1; }","duration":"125.151279ms","start":"2026-03-11T19:32:13.445113Z","end":"2026-03-11T19:32:13.570264Z","steps":["trace[1207421680] 'process raft request'  (duration: 124.865802ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:32:13.570376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.116241ms","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":"info","ts":"2026-03-11T19:32:13.57042Z","caller":"traceutil/trace.go:171","msg":"trace[1281552676] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2268; }","duration":"122.241263ms","start":"2026-03-11T19:32:13.448165Z","end":"2026-03-11T19:32:13.570406Z","steps":["trace[1281552676] 'agreement among raft nodes before linearized reading'  (duration: 122.10592ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:32:46.462031Z","caller":"traceutil/trace.go:171","msg":"trace[510258625] transaction","detail":"{read_only:false; response_revision:2450; number_of_response:1; }","duration":"172.584368ms","start":"2026-03-11T19:32:46.289424Z","end":"2026-03-11T19:32:46.462009Z","steps":["trace[510258625] 'process raft request'  (duration: 172.407544ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:32:46.907341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.612705ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827830396718873689 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2444 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-11T19:32:46.907462Z","caller":"traceutil/trace.go:171","msg":"trace[525710785] transaction","detail":"{read_only:false; response_revision:2452; number_of_response:1; }","duration":"208.17362ms","start":"2026-03-11T19:32:46.699266Z","end":"2026-03-11T19:32:46.90744Z","steps":["trace[525710785] 'process raft request'  (duration: 21.360071ms)","trace[525710785] 'compare'  (duration: 186.287856ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:32:47.063589Z","caller":"traceutil/trace.go:171","msg":"trace[452879936] transaction","detail":"{read_only:false; response_revision:2453; number_of_response:1; }","duration":"181.357454ms","start":"2026-03-11T19:32:46.882205Z","end":"2026-03-11T19:32:47.063563Z","steps":["trace[452879936] 'process raft request'  (duration: 166.802626ms)","trace[452879936] 'compare'  (duration: 14.446996ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:32:47.069117Z","caller":"traceutil/trace.go:171","msg":"trace[1707038096] transaction","detail":"{read_only:false; response_revision:2455; number_of_response:1; }","duration":"126.144872ms","start":"2026-03-11T19:32:46.942936Z","end":"2026-03-11T19:32:47.069081Z","steps":["trace[1707038096] 'process raft request'  (duration: 126.09596ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:32:47.069183Z","caller":"traceutil/trace.go:171","msg":"trace[655381485] transaction","detail":"{read_only:false; response_revision:2454; number_of_response:1; }","duration":"185.261214ms","start":"2026-03-11T19:32:46.883869Z","end":"2026-03-11T19:32:47.06913Z","steps":["trace[655381485] 'process raft request'  (duration: 184.990878ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:34:38.925764Z","caller":"traceutil/trace.go:171","msg":"trace[1712736545] transaction","detail":"{read_only:false; response_revision:3111; number_of_response:1; }","duration":"110.506083ms","start":"2026-03-11T19:34:38.815234Z","end":"2026-03-11T19:34:38.92574Z","steps":["trace[1712736545] 'process raft request'  (duration: 110.363679ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:36:36.824051Z","caller":"traceutil/trace.go:171","msg":"trace[925338342] transaction","detail":"{read_only:false; response_revision:4473; number_of_response:1; }","duration":"157.319721ms","start":"2026-03-11T19:36:36.666704Z","end":"2026-03-11T19:36:36.824024Z","steps":["trace[925338342] 'process raft request'  (duration: 157.074426ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:36:37.066906Z","caller":"traceutil/trace.go:171","msg":"trace[685370978] linearizableReadLoop","detail":"{readStateIndex:4652; appliedIndex:4650; }","duration":"268.301684ms","start":"2026-03-11T19:36:36.798571Z","end":"2026-03-11T19:36:37.066873Z","steps":["trace[685370978] 'read index received'  (duration: 25.167313ms)","trace[685370978] 'applied index is now lower than readState.Index'  (duration: 243.132351ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:36:37.067016Z","caller":"traceutil/trace.go:171","msg":"trace[90634690] transaction","detail":"{read_only:false; response_revision:4474; number_of_response:1; }","duration":"393.957416ms","start":"2026-03-11T19:36:36.673005Z","end":"2026-03-11T19:36:37.066962Z","steps":["trace[90634690] 'process raft request'  (duration: 314.662342ms)","trace[90634690] 'compare'  (duration: 79.046489ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T19:36:37.067092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.508289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T19:36:37.067149Z","caller":"traceutil/trace.go:171","msg":"trace[336863780] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4474; }","duration":"268.683603ms","start":"2026-03-11T19:36:36.79845Z","end":"2026-03-11T19:36:37.067134Z","steps":["trace[336863780] 'agreement among raft nodes before linearized reading'  (duration: 268.578441ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:36:37.067301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T19:36:36.672969Z","time spent":"394.182521ms","remote":"127.0.0.1:41748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:4244 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-03-11T19:36:37.07655Z","caller":"traceutil/trace.go:171","msg":"trace[1976411720] transaction","detail":"{read_only:false; response_revision:4475; number_of_response:1; }","duration":"247.085091ms","start":"2026-03-11T19:36:36.829446Z","end":"2026-03-11T19:36:37.076531Z","steps":["trace[1976411720] 'process raft request'  (duration: 246.862316ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:36:37.076735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.689183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fb2adf2b-0c7b-4174-809d-be56fe4ff9d7\" ","response":"range_response_count:1 size:3601"}
{"level":"info","ts":"2026-03-11T19:36:37.076806Z","caller":"traceutil/trace.go:171","msg":"trace[902797187] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fb2adf2b-0c7b-4174-809d-be56fe4ff9d7; range_end:; response_count:1; response_revision:4475; }","duration":"268.806906ms","start":"2026-03-11T19:36:36.80798Z","end":"2026-03-11T19:36:37.076787Z","steps":["trace[902797187] 'agreement among raft nodes before linearized reading'  (duration: 268.492329ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:36:37.077317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.64066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-tlz55-tls\" ","response":"range_response_count:1 size:2184"}
{"level":"info","ts":"2026-03-11T19:36:37.077417Z","caller":"traceutil/trace.go:171","msg":"trace[1271829023] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-tlz55-tls; range_end:; response_count:1; response_revision:4475; }","duration":"263.808054ms","start":"2026-03-11T19:36:36.813583Z","end":"2026-03-11T19:36:37.077391Z","steps":["trace[1271829023] 'agreement among raft nodes before linearized reading'  (duration: 263.027307ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:36:37.443549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.231122ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827830396718878651 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/monitoring/vector-ts6kr\" mod_revision:4485 > success:<request_put:<key:\"/registry/pods/monitoring/vector-ts6kr\" value_size:4888 >> failure:<request_range:<key:\"/registry/pods/monitoring/vector-ts6kr\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-11T19:36:37.443926Z","caller":"traceutil/trace.go:171","msg":"trace[756939286] transaction","detail":"{read_only:false; response_revision:4487; number_of_response:1; }","duration":"196.16917ms","start":"2026-03-11T19:36:37.247735Z","end":"2026-03-11T19:36:37.443904Z","steps":["trace[756939286] 'process raft request'  (duration: 41.473328ms)","trace[756939286] 'compare'  (duration: 154.056407ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:36:37.443941Z","caller":"traceutil/trace.go:171","msg":"trace[442647059] linearizableReadLoop","detail":"{readStateIndex:4666; appliedIndex:4664; }","duration":"175.618051ms","start":"2026-03-11T19:36:37.26829Z","end":"2026-03-11T19:36:37.443908Z","steps":["trace[442647059] 'read index received'  (duration: 20.919569ms)","trace[442647059] 'applied index is now lower than readState.Index'  (duration: 154.697332ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:36:37.444084Z","caller":"traceutil/trace.go:171","msg":"trace[1313008386] transaction","detail":"{read_only:false; response_revision:4488; number_of_response:1; }","duration":"192.850557ms","start":"2026-03-11T19:36:37.251222Z","end":"2026-03-11T19:36:37.444072Z","steps":["trace[1313008386] 'process raft request'  (duration: 192.509849ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:36:37.444363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.853996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-96k2p\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-03-11T19:36:37.444387Z","caller":"traceutil/trace.go:171","msg":"trace[1217907565] range","detail":"{range_begin:/registry/pods/openstack/keepalived-96k2p; range_end:; response_count:1; response_revision:4488; }","duration":"175.911667ms","start":"2026-03-11T19:36:37.268467Z","end":"2026-03-11T19:36:37.444379Z","steps":["trace[1217907565] 'agreement among raft nodes before linearized reading'  (duration: 175.776164ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:36:37.444423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.107252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-11T19:36:37.444461Z","caller":"traceutil/trace.go:171","msg":"trace[42559610] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4488; }","duration":"176.211064ms","start":"2026-03-11T19:36:37.26824Z","end":"2026-03-11T19:36:37.444451Z","steps":["trace[42559610] 'agreement among raft nodes before linearized reading'  (duration: 176.0332ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:36:37.445632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.695918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:777461"}
{"level":"info","ts":"2026-03-11T19:36:37.445684Z","caller":"traceutil/trace.go:171","msg":"trace[88554285] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:4488; }","duration":"144.758939ms","start":"2026-03-11T19:36:37.300898Z","end":"2026-03-11T19:36:37.445657Z","steps":["trace[88554285] 'agreement among raft nodes before linearized reading'  (duration: 143.568603ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:36:39.173833Z","caller":"traceutil/trace.go:171","msg":"trace[1870101974] linearizableReadLoop","detail":"{readStateIndex:4696; appliedIndex:4695; }","duration":"112.932117ms","start":"2026-03-11T19:36:39.06087Z","end":"2026-03-11T19:36:39.173802Z","steps":["trace[1870101974] 'read index received'  (duration: 103.035876ms)","trace[1870101974] 'applied index is now lower than readState.Index'  (duration: 9.892651ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:36:39.173873Z","caller":"traceutil/trace.go:171","msg":"trace[1138019378] transaction","detail":"{read_only:false; response_revision:4518; number_of_response:1; }","duration":"120.742092ms","start":"2026-03-11T19:36:39.0531Z","end":"2026-03-11T19:36:39.173842Z","steps":["trace[1138019378] 'process raft request'  (duration: 110.739839ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:36:39.174225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.327516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T19:36:39.17427Z","caller":"traceutil/trace.go:171","msg":"trace[1489010458] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:4518; }","duration":"113.437178ms","start":"2026-03-11T19:36:39.060823Z","end":"2026-03-11T19:36:39.17426Z","steps":["trace[1489010458] 'agreement among raft nodes before linearized reading'  (duration: 113.115721ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:36:39.182446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.85545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-11T19:36:39.181382Z","caller":"traceutil/trace.go:171","msg":"trace[2042758561] transaction","detail":"{read_only:false; response_revision:4519; number_of_response:1; }","duration":"120.411865ms","start":"2026-03-11T19:36:39.060929Z","end":"2026-03-11T19:36:39.181341Z","steps":["trace[2042758561] 'process raft request'  (duration: 119.907594ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:36:39.182581Z","caller":"traceutil/trace.go:171","msg":"trace[1153049153] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:4519; }","duration":"119.911603ms","start":"2026-03-11T19:36:39.062642Z","end":"2026-03-11T19:36:39.182553Z","steps":["trace[1153049153] 'agreement among raft nodes before linearized reading'  (duration: 118.720547ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:36:48.141867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.54921ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827830396718879094 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:4653 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-11T19:36:48.142002Z","caller":"traceutil/trace.go:171","msg":"trace[111759701] transaction","detail":"{read_only:false; response_revision:4693; number_of_response:1; }","duration":"215.511233ms","start":"2026-03-11T19:36:47.926469Z","end":"2026-03-11T19:36:48.141981Z","steps":["trace[111759701] 'process raft request'  (duration: 114.755018ms)","trace[111759701] 'compare'  (duration: 100.388846ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:36:48.187237Z","caller":"traceutil/trace.go:171","msg":"trace[1111553331] transaction","detail":"{read_only:false; response_revision:4694; number_of_response:1; }","duration":"260.203763ms","start":"2026-03-11T19:36:47.927011Z","end":"2026-03-11T19:36:48.187215Z","steps":["trace[1111553331] 'process raft request'  (duration: 259.849615ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:36:55.807325Z","caller":"traceutil/trace.go:171","msg":"trace[1580295900] transaction","detail":"{read_only:false; response_revision:4859; number_of_response:1; }","duration":"109.586313ms","start":"2026-03-11T19:36:55.697689Z","end":"2026-03-11T19:36:55.807275Z","steps":["trace[1580295900] 'process raft request'  (duration: 109.327127ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:36:56.182189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.23361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T19:36:56.182281Z","caller":"traceutil/trace.go:171","msg":"trace[2021060349] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:4861; }","duration":"103.385474ms","start":"2026-03-11T19:36:56.078874Z","end":"2026-03-11T19:36:56.182259Z","steps":["trace[2021060349] 'count revisions from in-memory index tree'  (duration: 103.144408ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:36:56.288197Z","caller":"traceutil/trace.go:171","msg":"trace[1811390768] transaction","detail":"{read_only:false; response_revision:4862; number_of_response:1; }","duration":"121.136802ms","start":"2026-03-11T19:36:56.167023Z","end":"2026-03-11T19:36:56.28816Z","steps":["trace[1811390768] 'process raft request'  (duration: 120.929817ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:36:58.463479Z","caller":"traceutil/trace.go:171","msg":"trace[1328934503] linearizableReadLoop","detail":"{readStateIndex:5077; appliedIndex:5076; }","duration":"158.541438ms","start":"2026-03-11T19:36:58.304907Z","end":"2026-03-11T19:36:58.463449Z","steps":["trace[1328934503] 'read index received'  (duration: 152.295239ms)","trace[1328934503] 'applied index is now lower than readState.Index'  (duration: 6.244819ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T19:36:58.463798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.895186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-03-11T19:36:58.463796Z","caller":"traceutil/trace.go:171","msg":"trace[532983601] transaction","detail":"{read_only:false; response_revision:4887; number_of_response:1; }","duration":"169.994504ms","start":"2026-03-11T19:36:58.29377Z","end":"2026-03-11T19:36:58.463764Z","steps":["trace[532983601] 'process raft request'  (duration: 163.511ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:36:58.463844Z","caller":"traceutil/trace.go:171","msg":"trace[838961121] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4887; }","duration":"159.002129ms","start":"2026-03-11T19:36:58.30483Z","end":"2026-03-11T19:36:58.463832Z","steps":["trace[838961121] 'agreement among raft nodes before linearized reading'  (duration: 158.731193ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:38:57.001851Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2795}
{"level":"info","ts":"2026-03-11T19:38:57.059127Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2795,"took":"55.780576ms","hash":1211671968,"current-db-size-bytes":42323968,"current-db-size":"42 MB","current-db-size-in-use-bytes":31932416,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-03-11T19:38:57.0592Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1211671968,"revision":2795,"compact-revision":-1}
{"level":"warn","ts":"2026-03-11T19:43:16.134914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.981687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19446"}
{"level":"info","ts":"2026-03-11T19:43:16.135006Z","caller":"traceutil/trace.go:171","msg":"trace[870476641] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:7577; }","duration":"105.100519ms","start":"2026-03-11T19:43:16.029887Z","end":"2026-03-11T19:43:16.134987Z","steps":["trace[870476641] 'range keys from in-memory index tree'  (duration: 104.804323ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:43:16.221776Z","caller":"traceutil/trace.go:171","msg":"trace[1459426552] transaction","detail":"{read_only:false; response_revision:7578; number_of_response:1; }","duration":"128.311298ms","start":"2026-03-11T19:43:16.093428Z","end":"2026-03-11T19:43:16.221739Z","steps":["trace[1459426552] 'process raft request'  (duration: 128.055313ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:43:17.850417Z","caller":"traceutil/trace.go:171","msg":"trace[1183704959] transaction","detail":"{read_only:false; response_revision:7581; number_of_response:1; }","duration":"171.219536ms","start":"2026-03-11T19:43:17.679175Z","end":"2026-03-11T19:43:17.850395Z","steps":["trace[1183704959] 'process raft request'  (duration: 171.039702ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:43:44.44558Z","caller":"traceutil/trace.go:171","msg":"trace[349609221] transaction","detail":"{read_only:false; response_revision:7767; number_of_response:1; }","duration":"438.917736ms","start":"2026-03-11T19:43:44.006642Z","end":"2026-03-11T19:43:44.44556Z","steps":["trace[349609221] 'process raft request'  (duration: 438.785513ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:43:44.445707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T19:43:44.006627Z","time spent":"439.018228ms","remote":"127.0.0.1:41748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:7759 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-11T19:43:44.705641Z","caller":"traceutil/trace.go:171","msg":"trace[359905348] linearizableReadLoop","detail":"{readStateIndex:8059; appliedIndex:8057; }","duration":"639.113583ms","start":"2026-03-11T19:43:44.066504Z","end":"2026-03-11T19:43:44.705618Z","steps":["trace[359905348] 'read index received'  (duration: 379.049828ms)","trace[359905348] 'applied index is now lower than readState.Index'  (duration: 260.062635ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:43:44.70573Z","caller":"traceutil/trace.go:171","msg":"trace[231977290] transaction","detail":"{read_only:false; response_revision:7768; number_of_response:1; }","duration":"697.715785ms","start":"2026-03-11T19:43:44.008001Z","end":"2026-03-11T19:43:44.705717Z","steps":["trace[231977290] 'process raft request'  (duration: 689.782477ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:43:44.70577Z","caller":"traceutil/trace.go:171","msg":"trace[522928750] transaction","detail":"{read_only:false; response_revision:7769; number_of_response:1; }","duration":"692.14276ms","start":"2026-03-11T19:43:44.013617Z","end":"2026-03-11T19:43:44.70576Z","steps":["trace[522928750] 'process raft request'  (duration: 691.858682ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:43:44.705825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T19:43:44.00799Z","time spent":"697.772366ms","remote":"127.0.0.1:41748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:7760 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-11T19:43:44.705839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T19:43:44.013604Z","time spent":"692.190531ms","remote":"127.0.0.1:41748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:7761 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-03-11T19:43:44.706011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.511553ms","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-03-11T19:43:44.70605Z","caller":"traceutil/trace.go:171","msg":"trace[1862764840] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7769; }","duration":"639.577144ms","start":"2026-03-11T19:43:44.066463Z","end":"2026-03-11T19:43:44.70604Z","steps":["trace[1862764840] 'agreement among raft nodes before linearized reading'  (duration: 639.457171ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:43:44.706079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T19:43:44.066448Z","time spent":"639.625585ms","remote":"127.0.0.1:41748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-11T19:43:44.706297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.820362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-96k2p\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-03-11T19:43:44.706336Z","caller":"traceutil/trace.go:171","msg":"trace[628607535] range","detail":"{range_begin:/registry/pods/openstack/keepalived-96k2p; range_end:; response_count:1; response_revision:7769; }","duration":"615.859003ms","start":"2026-03-11T19:43:44.090468Z","end":"2026-03-11T19:43:44.706327Z","steps":["trace[628607535] 'agreement among raft nodes before linearized reading'  (duration: 615.764081ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:43:44.706411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T19:43:44.090387Z","time spent":"616.017427ms","remote":"127.0.0.1:41670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6554,"request content":"key:\"/registry/pods/openstack/keepalived-96k2p\" "}
{"level":"warn","ts":"2026-03-11T19:43:44.706491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.515524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-11T19:43:44.70657Z","caller":"traceutil/trace.go:171","msg":"trace[851893868] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7769; }","duration":"162.644447ms","start":"2026-03-11T19:43:44.543909Z","end":"2026-03-11T19:43:44.706554Z","steps":["trace[851893868] 'agreement among raft nodes before linearized reading'  (duration: 162.426132ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:43:48.327778Z","caller":"traceutil/trace.go:171","msg":"trace[1789354845] transaction","detail":"{read_only:false; response_revision:7783; number_of_response:1; }","duration":"370.851904ms","start":"2026-03-11T19:43:47.956901Z","end":"2026-03-11T19:43:48.327753Z","steps":["trace[1789354845] 'process raft request'  (duration: 370.68883ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:43:48.327966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T19:43:47.956884Z","time spent":"370.981166ms","remote":"127.0.0.1:41748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:7774 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-03-11T19:43:48.334049Z","caller":"traceutil/trace.go:171","msg":"trace[227396595] transaction","detail":"{read_only:false; response_revision:7784; number_of_response:1; }","duration":"340.047786ms","start":"2026-03-11T19:43:47.993972Z","end":"2026-03-11T19:43:48.33402Z","steps":["trace[227396595] 'process raft request'  (duration: 339.909093ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:43:48.334217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T19:43:47.993945Z","time spent":"340.184418ms","remote":"127.0.0.1:41748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:7775 > 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-03-11T19:43:57.104854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.614037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T19:43:57.105006Z","caller":"traceutil/trace.go:171","msg":"trace[1271370830] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:7872; }","duration":"128.842732ms","start":"2026-03-11T19:43:56.976137Z","end":"2026-03-11T19:43:57.10498Z","steps":["trace[1271370830] 'range keys from in-memory index tree'  (duration: 128.496574ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:43:57.117978Z","caller":"traceutil/trace.go:171","msg":"trace[435525829] transaction","detail":"{read_only:false; response_revision:7873; number_of_response:1; }","duration":"113.874276ms","start":"2026-03-11T19:43:57.00404Z","end":"2026-03-11T19:43:57.117914Z","steps":["trace[435525829] 'process raft request'  (duration: 113.540179ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:43:57.357976Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5805}
{"level":"warn","ts":"2026-03-11T19:43:57.359338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.785742ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827830396718887738 username:\"kube-apiserver-etcd-client\" auth_revision:1 > compaction:<revision:5805 > ","response":"size:5"}
{"level":"info","ts":"2026-03-11T19:43:57.359616Z","caller":"traceutil/trace.go:171","msg":"trace[294957159] compact","detail":"{revision:5805; response_revision:7873; }","duration":"240.324374ms","start":"2026-03-11T19:43:57.119246Z","end":"2026-03-11T19:43:57.359571Z","steps":["trace[294957159] 'process raft request'  (duration: 28.568378ms)","trace[294957159] 'check and update compact revision'  (duration: 209.592278ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:43:57.359708Z","caller":"traceutil/trace.go:171","msg":"trace[1366442097] linearizableReadLoop","detail":"{readStateIndex:8170; appliedIndex:8169; }","duration":"233.623135ms","start":"2026-03-11T19:43:57.126034Z","end":"2026-03-11T19:43:57.359657Z","steps":["trace[1366442097] 'read index received'  (duration: 21.702665ms)","trace[1366442097] 'applied index is now lower than readState.Index'  (duration: 211.9147ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T19:43:57.360078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.011663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-03-11T19:43:57.360191Z","caller":"traceutil/trace.go:171","msg":"trace[1542318080] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:7873; }","duration":"234.198617ms","start":"2026-03-11T19:43:57.125971Z","end":"2026-03-11T19:43:57.360169Z","steps":["trace[1542318080] 'agreement among raft nodes before linearized reading'  (duration: 233.778958ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:43:57.360928Z","caller":"traceutil/trace.go:171","msg":"trace[1729055655] transaction","detail":"{read_only:false; response_revision:7874; number_of_response:1; }","duration":"197.734352ms","start":"2026-03-11T19:43:57.163149Z","end":"2026-03-11T19:43:57.360883Z","steps":["trace[1729055655] 'process raft request'  (duration: 197.19733ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:43:57.662869Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5805,"took":"300.990262ms","hash":2058024073,"current-db-size-bytes":43044864,"current-db-size":"43 MB","current-db-size-in-use-bytes":23519232,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-03-11T19:43:57.662964Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2058024073,"revision":5805,"compact-revision":2795}
{"level":"info","ts":"2026-03-11T19:43:58.106481Z","caller":"traceutil/trace.go:171","msg":"trace[1247417081] transaction","detail":"{read_only:false; response_revision:7877; number_of_response:1; }","duration":"210.058927ms","start":"2026-03-11T19:43:57.896383Z","end":"2026-03-11T19:43:58.106442Z","steps":["trace[1247417081] 'process raft request'  (duration: 209.819762ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:43:58.513915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.397457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"}
{"level":"info","ts":"2026-03-11T19:43:58.513991Z","caller":"traceutil/trace.go:171","msg":"trace[708636945] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:7877; }","duration":"198.51447ms","start":"2026-03-11T19:43:58.31546Z","end":"2026-03-11T19:43:58.513974Z","steps":["trace[708636945] 'range keys from in-memory index tree'  (duration: 198.155362ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:43:58.514137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.91518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-11T19:43:58.514244Z","caller":"traceutil/trace.go:171","msg":"trace[182260239] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:7877; }","duration":"195.048872ms","start":"2026-03-11T19:43:58.319175Z","end":"2026-03-11T19:43:58.514223Z","steps":["trace[182260239] 'count revisions from in-memory index tree'  (duration: 194.854158ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:43:58.514803Z","caller":"traceutil/trace.go:171","msg":"trace[783887459] transaction","detail":"{read_only:false; response_revision:7878; number_of_response:1; }","duration":"146.391333ms","start":"2026-03-11T19:43:58.368386Z","end":"2026-03-11T19:43:58.514777Z","steps":["trace[783887459] 'process raft request'  (duration: 141.882912ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:43:58.515412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.702896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:128439"}
{"level":"info","ts":"2026-03-11T19:43:58.515454Z","caller":"traceutil/trace.go:171","msg":"trace[1089538110] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:7877; }","duration":"191.799719ms","start":"2026-03-11T19:43:58.323644Z","end":"2026-03-11T19:43:58.515444Z","steps":["trace[1089538110] 'range keys from in-memory index tree'  (duration: 190.52897ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:43:58.550283Z","caller":"traceutil/trace.go:171","msg":"trace[868710759] linearizableReadLoop","detail":"{readStateIndex:8176; appliedIndex:8174; }","duration":"151.634472ms","start":"2026-03-11T19:43:58.398635Z","end":"2026-03-11T19:43:58.550269Z","steps":["trace[868710759] 'read index received'  (duration: 111.737899ms)","trace[868710759] 'applied index is now lower than readState.Index'  (duration: 39.895783ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:43:58.550481Z","caller":"traceutil/trace.go:171","msg":"trace[250454555] transaction","detail":"{read_only:false; response_revision:7879; number_of_response:1; }","duration":"177.4871ms","start":"2026-03-11T19:43:58.372923Z","end":"2026-03-11T19:43:58.55041Z","steps":["trace[250454555] 'process raft request'  (duration: 177.246514ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:43:58.551627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.980311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2210989"}
{"level":"info","ts":"2026-03-11T19:43:58.551694Z","caller":"traceutil/trace.go:171","msg":"trace[2009618176] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:7879; }","duration":"153.080494ms","start":"2026-03-11T19:43:58.398599Z","end":"2026-03-11T19:43:58.551679Z","steps":["trace[2009618176] 'agreement among raft nodes before linearized reading'  (duration: 151.788875ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:47:26.092883Z","caller":"traceutil/trace.go:171","msg":"trace[1440525945] transaction","detail":"{read_only:false; response_revision:9542; number_of_response:1; }","duration":"187.290662ms","start":"2026-03-11T19:47:25.905564Z","end":"2026-03-11T19:47:26.092855Z","steps":["trace[1440525945] 'process raft request'  (duration: 177.894712ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:47:26.111031Z","caller":"traceutil/trace.go:171","msg":"trace[1377670792] linearizableReadLoop","detail":"{readStateIndex:9892; appliedIndex:9890; }","duration":"160.26578ms","start":"2026-03-11T19:47:25.950736Z","end":"2026-03-11T19:47:26.111002Z","steps":["trace[1377670792] 'read index received'  (duration: 132.720036ms)","trace[1377670792] 'applied index is now lower than readState.Index'  (duration: 27.544494ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:47:26.111115Z","caller":"traceutil/trace.go:171","msg":"trace[1677977] transaction","detail":"{read_only:false; response_revision:9543; number_of_response:1; }","duration":"203.783879ms","start":"2026-03-11T19:47:25.907276Z","end":"2026-03-11T19:47:26.11106Z","steps":["trace[1677977] 'process raft request'  (duration: 203.540674ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:47:26.111259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.508295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/staffeln-db-init-lmx5v\" ","response":"range_response_count:1 size:7346"}
{"level":"info","ts":"2026-03-11T19:47:26.111307Z","caller":"traceutil/trace.go:171","msg":"trace[605316418] range","detail":"{range_begin:/registry/pods/openstack/staffeln-db-init-lmx5v; range_end:; response_count:1; response_revision:9543; }","duration":"160.570186ms","start":"2026-03-11T19:47:25.950721Z","end":"2026-03-11T19:47:26.111291Z","steps":["trace[605316418] 'agreement among raft nodes before linearized reading'  (duration: 160.388902ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:47:41.15995Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e3aaa5c123e150e0","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-03-11T19:47:41.16564Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-03-11T19:47:41.165729Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-03-11T19:48:57.375079Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7873}
{"level":"info","ts":"2026-03-11T19:48:57.482154Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7873,"took":"104.447339ms","hash":921896997,"current-db-size-bytes":43044864,"current-db-size":"43 MB","current-db-size-in-use-bytes":25759744,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-03-11T19:48:57.482246Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":921896997,"revision":7873,"compact-revision":5805}
{"level":"info","ts":"2026-03-11T19:49:38.482066Z","caller":"traceutil/trace.go:171","msg":"trace[328073400] transaction","detail":"{read_only:false; response_revision:10219; number_of_response:1; }","duration":"119.115852ms","start":"2026-03-11T19:49:38.36292Z","end":"2026-03-11T19:49:38.482036Z","steps":["trace[328073400] 'process raft request'  (duration: 118.971809ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:49:38.742209Z","caller":"traceutil/trace.go:171","msg":"trace[11294404] transaction","detail":"{read_only:false; response_revision:10221; number_of_response:1; }","duration":"136.543207ms","start":"2026-03-11T19:49:38.605635Z","end":"2026-03-11T19:49:38.742179Z","steps":["trace[11294404] 'process raft request'  (duration: 131.316062ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:52:29.739467Z","caller":"traceutil/trace.go:171","msg":"trace[2048186342] transaction","detail":"{read_only:false; response_revision:11005; number_of_response:1; }","duration":"101.019037ms","start":"2026-03-11T19:52:29.638419Z","end":"2026-03-11T19:52:29.739438Z","steps":["trace[2048186342] 'process raft request'  (duration: 100.839813ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:52:30.070983Z","caller":"traceutil/trace.go:171","msg":"trace[834230227] transaction","detail":"{read_only:false; response_revision:11007; number_of_response:1; }","duration":"131.465291ms","start":"2026-03-11T19:52:29.939457Z","end":"2026-03-11T19:52:30.070923Z","steps":["trace[834230227] 'process raft request'  (duration: 82.973247ms)","trace[834230227] 'compare'  (duration: 48.275229ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:52:30.795304Z","caller":"traceutil/trace.go:171","msg":"trace[532048119] transaction","detail":"{read_only:false; response_revision:11013; number_of_response:1; }","duration":"173.40802ms","start":"2026-03-11T19:52:30.621862Z","end":"2026-03-11T19:52:30.79527Z","steps":["trace[532048119] 'process raft request'  (duration: 170.603168ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:52:30.829589Z","caller":"traceutil/trace.go:171","msg":"trace[605190598] transaction","detail":"{read_only:false; response_revision:11014; number_of_response:1; }","duration":"196.196654ms","start":"2026-03-11T19:52:30.633323Z","end":"2026-03-11T19:52:30.829519Z","steps":["trace[605190598] 'process raft request'  (duration: 195.309735ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:03.219371Z","caller":"traceutil/trace.go:171","msg":"trace[15379651] linearizableReadLoop","detail":"{readStateIndex:11582; appliedIndex:11581; }","duration":"210.812227ms","start":"2026-03-11T19:53:03.008539Z","end":"2026-03-11T19:53:03.219352Z","steps":["trace[15379651] 'read index received'  (duration: 210.797207ms)","trace[15379651] 'applied index is now lower than readState.Index'  (duration: 14µs)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:53:03.21945Z","caller":"traceutil/trace.go:171","msg":"trace[1045026587] transaction","detail":"{read_only:false; response_revision:11161; number_of_response:1; }","duration":"227.923376ms","start":"2026-03-11T19:53:02.991466Z","end":"2026-03-11T19:53:03.21939Z","steps":["trace[1045026587] 'process raft request'  (duration: 227.762482ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:03.219574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.010891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/auth-system/default\" ","response":"range_response_count:1 size:179"}
{"level":"info","ts":"2026-03-11T19:53:03.219638Z","caller":"traceutil/trace.go:171","msg":"trace[316297311] range","detail":"{range_begin:/registry/serviceaccounts/auth-system/default; range_end:; response_count:1; response_revision:11161; }","duration":"211.113184ms","start":"2026-03-11T19:53:03.008511Z","end":"2026-03-11T19:53:03.219624Z","steps":["trace[316297311] 'agreement among raft nodes before linearized reading'  (duration: 210.92835ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:03.268726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.57287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/kube-public/\" range_end:\"/registry/services/endpoints/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T19:53:03.268824Z","caller":"traceutil/trace.go:171","msg":"trace[9618551] transaction","detail":"{read_only:false; response_revision:11162; number_of_response:1; }","duration":"223.271634ms","start":"2026-03-11T19:53:03.045514Z","end":"2026-03-11T19:53:03.268785Z","steps":["trace[9618551] 'process raft request'  (duration: 222.905976ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:03.26887Z","caller":"traceutil/trace.go:171","msg":"trace[1741852831] range","detail":"{range_begin:/registry/services/endpoints/kube-public/; range_end:/registry/services/endpoints/kube-public0; response_count:0; response_revision:11162; }","duration":"251.763814ms","start":"2026-03-11T19:53:03.017076Z","end":"2026-03-11T19:53:03.26884Z","steps":["trace[1741852831] 'agreement among raft nodes before linearized reading'  (duration: 251.531669ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:03.268864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.192427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-node-lease/\" range_end:\"/registry/pods/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-11T19:53:03.268921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.151903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/cert-manager/cert-manager-webhook\" ","response":"range_response_count:1 size:1391"}
{"level":"info","ts":"2026-03-11T19:53:03.268961Z","caller":"traceutil/trace.go:171","msg":"trace[1849002656] range","detail":"{range_begin:/registry/pods/kube-node-lease/; range_end:/registry/pods/kube-node-lease0; response_count:0; response_revision:11162; }","duration":"249.3104ms","start":"2026-03-11T19:53:03.019622Z","end":"2026-03-11T19:53:03.268933Z","steps":["trace[1849002656] 'agreement among raft nodes before linearized reading'  (duration: 249.132096ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:03.269011Z","caller":"traceutil/trace.go:171","msg":"trace[934113057] range","detail":"{range_begin:/registry/services/specs/cert-manager/cert-manager-webhook; range_end:; response_count:1; response_revision:11162; }","duration":"210.291226ms","start":"2026-03-11T19:53:03.058696Z","end":"2026-03-11T19:53:03.268987Z","steps":["trace[934113057] 'agreement among raft nodes before linearized reading'  (duration: 210.00563ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:04.145938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.020337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/kube-public/\" range_end:\"/registry/persistentvolumeclaims/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T19:53:04.146027Z","caller":"traceutil/trace.go:171","msg":"trace[964259692] range","detail":"{range_begin:/registry/persistentvolumeclaims/kube-public/; range_end:/registry/persistentvolumeclaims/kube-public0; response_count:0; response_revision:11163; }","duration":"199.138329ms","start":"2026-03-11T19:53:03.946868Z","end":"2026-03-11T19:53:04.146006Z","steps":["trace[964259692] 'range keys from in-memory index tree'  (duration: 198.937844ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:04.146066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.488076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/auth-system/keycloak\" ","response":"range_response_count:1 size:7506"}
{"level":"info","ts":"2026-03-11T19:53:04.146114Z","caller":"traceutil/trace.go:171","msg":"trace[1726150125] range","detail":"{range_begin:/registry/statefulsets/auth-system/keycloak; range_end:; response_count:1; response_revision:11163; }","duration":"203.565137ms","start":"2026-03-11T19:53:03.942536Z","end":"2026-03-11T19:53:04.146101Z","steps":["trace[1726150125] 'range keys from in-memory index tree'  (duration: 203.342053ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:04.14624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.6618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T19:53:04.146296Z","caller":"traceutil/trace.go:171","msg":"trace[232054833] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:11163; }","duration":"222.722402ms","start":"2026-03-11T19:53:03.923559Z","end":"2026-03-11T19:53:04.146282Z","steps":["trace[232054833] 'count revisions from in-memory index tree'  (duration: 222.549347ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:04.146339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.369093ms","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-03-11T19:53:04.146437Z","caller":"traceutil/trace.go:171","msg":"trace[1766590433] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11163; }","duration":"222.485886ms","start":"2026-03-11T19:53:03.923933Z","end":"2026-03-11T19:53:04.146419Z","steps":["trace[1766590433] 'range keys from in-memory index tree'  (duration: 222.25389ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:04.146444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.061619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/default/kube-root-ca.crt\" ","response":"range_response_count:1 size:1738"}
{"level":"warn","ts":"2026-03-11T19:53:04.146339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.416518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-node-lease/\" range_end:\"/registry/serviceaccounts/kube-node-lease0\" limit:500 ","response":"range_response_count:1 size:187"}
{"level":"info","ts":"2026-03-11T19:53:04.146518Z","caller":"traceutil/trace.go:171","msg":"trace[443109953] range","detail":"{range_begin:/registry/configmaps/default/kube-root-ca.crt; range_end:; response_count:1; response_revision:11163; }","duration":"200.160471ms","start":"2026-03-11T19:53:03.946317Z","end":"2026-03-11T19:53:04.146478Z","steps":["trace[443109953] 'range keys from in-memory index tree'  (duration: 199.802364ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:04.146544Z","caller":"traceutil/trace.go:171","msg":"trace[286947965] range","detail":"{range_begin:/registry/serviceaccounts/kube-node-lease/; range_end:/registry/serviceaccounts/kube-node-lease0; response_count:1; response_revision:11163; }","duration":"200.592922ms","start":"2026-03-11T19:53:03.945907Z","end":"2026-03-11T19:53:04.1465Z","steps":["trace[286947965] 'range keys from in-memory index tree'  (duration: 200.333896ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:06.977959Z","caller":"traceutil/trace.go:171","msg":"trace[1298814814] linearizableReadLoop","detail":"{readStateIndex:11599; appliedIndex:11598; }","duration":"138.737182ms","start":"2026-03-11T19:53:06.839203Z","end":"2026-03-11T19:53:06.97794Z","steps":["trace[1298814814] 'read index received'  (duration: 94.780748ms)","trace[1298814814] 'applied index is now lower than readState.Index'  (duration: 43.955684ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T19:53:06.978101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.549986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T19:53:06.978069Z","caller":"traceutil/trace.go:171","msg":"trace[1499128202] transaction","detail":"{read_only:false; response_revision:11177; number_of_response:1; }","duration":"207.503974ms","start":"2026-03-11T19:53:06.770519Z","end":"2026-03-11T19:53:06.978023Z","steps":["trace[1499128202] 'process raft request'  (duration: 163.431428ms)","trace[1499128202] 'compare'  (duration: 43.901302ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:53:06.978128Z","caller":"traceutil/trace.go:171","msg":"trace[1697011906] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:11177; }","duration":"142.624788ms","start":"2026-03-11T19:53:06.835496Z","end":"2026-03-11T19:53:06.97812Z","steps":["trace[1697011906] 'agreement among raft nodes before linearized reading'  (duration: 142.540266ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:06.978215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.64161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T19:53:06.978318Z","caller":"traceutil/trace.go:171","msg":"trace[581157880] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11177; }","duration":"180.807553ms","start":"2026-03-11T19:53:06.797488Z","end":"2026-03-11T19:53:06.978296Z","steps":["trace[581157880] 'agreement among raft nodes before linearized reading'  (duration: 180.623329ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:06.978364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.00448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/ingress-nginx/ingress-nginx-backend\" ","response":"range_response_count:1 size:1041"}
{"level":"info","ts":"2026-03-11T19:53:06.97848Z","caller":"traceutil/trace.go:171","msg":"trace[253174830] range","detail":"{range_begin:/registry/serviceaccounts/ingress-nginx/ingress-nginx-backend; range_end:; response_count:1; response_revision:11177; }","duration":"173.173384ms","start":"2026-03-11T19:53:06.805286Z","end":"2026-03-11T19:53:06.97846Z","steps":["trace[253174830] 'agreement among raft nodes before linearized reading'  (duration: 172.874748ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:06.978573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.424699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/ingress-nginx/\" range_end:\"/registry/events/ingress-nginx0\" limit:500 ","response":"range_response_count:30 size:23669"}
{"level":"info","ts":"2026-03-11T19:53:06.978643Z","caller":"traceutil/trace.go:171","msg":"trace[1556052045] range","detail":"{range_begin:/registry/events/ingress-nginx/; range_end:/registry/events/ingress-nginx0; response_count:30; response_revision:11177; }","duration":"126.526431ms","start":"2026-03-11T19:53:06.852099Z","end":"2026-03-11T19:53:06.978626Z","steps":["trace[1556052045] 'agreement among raft nodes before linearized reading'  (duration: 126.159213ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:06.978994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.041101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/\" range_end:\"/registry/configmaps/openstack0\" limit:500 ","response":"range_response_count:25 size:174179"}
{"level":"info","ts":"2026-03-11T19:53:06.979105Z","caller":"traceutil/trace.go:171","msg":"trace[67909209] range","detail":"{range_begin:/registry/configmaps/openstack/; range_end:/registry/configmaps/openstack0; response_count:25; response_revision:11177; }","duration":"117.131084ms","start":"2026-03-11T19:53:06.861916Z","end":"2026-03-11T19:53:06.979047Z","steps":["trace[67909209] 'agreement among raft nodes before linearized reading'  (duration: 116.341777ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:10.258584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.916898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/secretgen-controller/\" range_end:\"/registry/jobs/secretgen-controller0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T19:53:10.258675Z","caller":"traceutil/trace.go:171","msg":"trace[1553043695] range","detail":"{range_begin:/registry/jobs/secretgen-controller/; range_end:/registry/jobs/secretgen-controller0; response_count:0; response_revision:11192; }","duration":"126.050931ms","start":"2026-03-11T19:53:10.132603Z","end":"2026-03-11T19:53:10.258654Z","steps":["trace[1553043695] 'range keys from in-memory index tree'  (duration: 125.845516ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:10.258949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.341133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/kube-system/kube-prometheus-stack-kubelet\" ","response":"range_response_count:1 size:684"}
{"level":"info","ts":"2026-03-11T19:53:10.259071Z","caller":"traceutil/trace.go:171","msg":"trace[1811049358] range","detail":"{range_begin:/registry/services/endpoints/kube-system/kube-prometheus-stack-kubelet; range_end:; response_count:1; response_revision:11192; }","duration":"101.492466ms","start":"2026-03-11T19:53:10.157554Z","end":"2026-03-11T19:53:10.259047Z","steps":["trace[1811049358] 'range keys from in-memory index tree'  (duration: 101.112238ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:10.94745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.132044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/secretgen-controller/\" range_end:\"/registry/persistentvolumeclaims/secretgen-controller0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T19:53:10.947536Z","caller":"traceutil/trace.go:171","msg":"trace[2098897201] range","detail":"{range_begin:/registry/persistentvolumeclaims/secretgen-controller/; range_end:/registry/persistentvolumeclaims/secretgen-controller0; response_count:0; response_revision:11196; }","duration":"187.239946ms","start":"2026-03-11T19:53:10.760277Z","end":"2026-03-11T19:53:10.947517Z","steps":["trace[2098897201] 'range keys from in-memory index tree'  (duration: 187.022451ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:10.94778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.004918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/rook-ceph/\" range_end:\"/registry/serviceaccounts/rook-ceph0\" limit:500 ","response":"range_response_count:13 size:8443"}
{"level":"warn","ts":"2026-03-11T19:53:10.947783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.001337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-96k2p\" ","response":"range_response_count:1 size:6531"}
{"level":"warn","ts":"2026-03-11T19:53:10.947774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.410695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-hnh4s\" ","response":"range_response_count:1 size:4908"}
{"level":"warn","ts":"2026-03-11T19:53:10.947801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.019513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-lwfq2\" ","response":"range_response_count:1 size:4908"}
{"level":"info","ts":"2026-03-11T19:53:10.947836Z","caller":"traceutil/trace.go:171","msg":"trace[1291911036] range","detail":"{range_begin:/registry/serviceaccounts/rook-ceph/; range_end:/registry/serviceaccounts/rook-ceph0; response_count:13; response_revision:11196; }","duration":"191.083981ms","start":"2026-03-11T19:53:10.756739Z","end":"2026-03-11T19:53:10.947823Z","steps":["trace[1291911036] 'range keys from in-memory index tree'  (duration: 190.780404ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:10.947857Z","caller":"traceutil/trace.go:171","msg":"trace[987518289] range","detail":"{range_begin:/registry/pods/openstack/keepalived-96k2p; range_end:; response_count:1; response_revision:11196; }","duration":"223.07639ms","start":"2026-03-11T19:53:10.724752Z","end":"2026-03-11T19:53:10.947828Z","steps":["trace[987518289] 'range keys from in-memory index tree'  (duration: 222.885115ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:10.947872Z","caller":"traceutil/trace.go:171","msg":"trace[513812153] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-lwfq2; range_end:; response_count:1; response_revision:11196; }","duration":"230.124895ms","start":"2026-03-11T19:53:10.717727Z","end":"2026-03-11T19:53:10.947852Z","steps":["trace[513812153] 'range keys from in-memory index tree'  (duration: 229.88216ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:10.947873Z","caller":"traceutil/trace.go:171","msg":"trace[1630752101] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-hnh4s; range_end:; response_count:1; response_revision:11196; }","duration":"264.551928ms","start":"2026-03-11T19:53:10.683294Z","end":"2026-03-11T19:53:10.947846Z","steps":["trace[1630752101] 'range keys from in-memory index tree'  (duration: 264.170549ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:26.94304Z","caller":"traceutil/trace.go:171","msg":"trace[91393776] linearizableReadLoop","detail":"{readStateIndex:11695; appliedIndex:11694; }","duration":"128.438454ms","start":"2026-03-11T19:53:26.814579Z","end":"2026-03-11T19:53:26.943017Z","steps":["trace[91393776] 'read index received'  (duration: 128.25235ms)","trace[91393776] 'applied index is now lower than readState.Index'  (duration: 185.234µs)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:53:26.943175Z","caller":"traceutil/trace.go:171","msg":"trace[393350553] transaction","detail":"{read_only:false; response_revision:11269; number_of_response:1; }","duration":"128.615558ms","start":"2026-03-11T19:53:26.814519Z","end":"2026-03-11T19:53:26.943134Z","steps":["trace[393350553] 'process raft request'  (duration: 128.354902ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:26.943317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.27617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-barbican-plugins-conf\" ","response":"range_response_count:1 size:847"}
{"level":"info","ts":"2026-03-11T19:53:26.943407Z","caller":"traceutil/trace.go:171","msg":"trace[1906128691] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-barbican-plugins-conf; range_end:; response_count:1; response_revision:11269; }","duration":"128.375312ms","start":"2026-03-11T19:53:26.815013Z","end":"2026-03-11T19:53:26.943388Z","steps":["trace[1906128691] 'agreement among raft nodes before linearized reading'  (duration: 128.145167ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:26.943442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.832983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/monitoring/goldpinger\" ","response":"range_response_count:1 size:934"}
{"level":"info","ts":"2026-03-11T19:53:26.943539Z","caller":"traceutil/trace.go:171","msg":"trace[1296153075] range","detail":"{range_begin:/registry/services/endpoints/monitoring/goldpinger; range_end:; response_count:1; response_revision:11269; }","duration":"128.990686ms","start":"2026-03-11T19:53:26.814528Z","end":"2026-03-11T19:53:26.943519Z","steps":["trace[1296153075] 'agreement among raft nodes before linearized reading'  (duration: 128.636308ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:27.264154Z","caller":"traceutil/trace.go:171","msg":"trace[1910744431] linearizableReadLoop","detail":"{readStateIndex:11697; appliedIndex:11696; }","duration":"127.806219ms","start":"2026-03-11T19:53:27.136316Z","end":"2026-03-11T19:53:27.264122Z","steps":["trace[1910744431] 'read index received'  (duration: 68.795443ms)","trace[1910744431] 'applied index is now lower than readState.Index'  (duration: 59.009356ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:53:27.264251Z","caller":"traceutil/trace.go:171","msg":"trace[669103050] transaction","detail":"{read_only:false; response_revision:11271; number_of_response:1; }","duration":"157.712931ms","start":"2026-03-11T19:53:27.106515Z","end":"2026-03-11T19:53:27.264228Z","steps":["trace[669103050] 'process raft request'  (duration: 98.651384ms)","trace[669103050] 'compare'  (duration: 58.821812ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T19:53:27.264419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.091936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-96k2p\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-03-11T19:53:27.264487Z","caller":"traceutil/trace.go:171","msg":"trace[617046444] range","detail":"{range_begin:/registry/pods/openstack/keepalived-96k2p; range_end:; response_count:1; response_revision:11271; }","duration":"128.167177ms","start":"2026-03-11T19:53:27.136297Z","end":"2026-03-11T19:53:27.264464Z","steps":["trace[617046444] 'agreement among raft nodes before linearized reading'  (duration: 127.998054ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:28.287309Z","caller":"traceutil/trace.go:171","msg":"trace[2002617524] linearizableReadLoop","detail":"{readStateIndex:11699; appliedIndex:11698; }","duration":"131.844219ms","start":"2026-03-11T19:53:28.155444Z","end":"2026-03-11T19:53:28.287288Z","steps":["trace[2002617524] 'read index received'  (duration: 131.611494ms)","trace[2002617524] 'applied index is now lower than readState.Index'  (duration: 231.855µs)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:53:28.287371Z","caller":"traceutil/trace.go:171","msg":"trace[71597925] transaction","detail":"{read_only:false; response_revision:11273; number_of_response:1; }","duration":"149.457198ms","start":"2026-03-11T19:53:28.137877Z","end":"2026-03-11T19:53:28.287334Z","steps":["trace[71597925] 'process raft request'  (duration: 149.234103ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:28.28751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.056375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:356"}
{"level":"info","ts":"2026-03-11T19:53:28.287551Z","caller":"traceutil/trace.go:171","msg":"trace[1115343262] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:11273; }","duration":"132.109536ms","start":"2026-03-11T19:53:28.155432Z","end":"2026-03-11T19:53:28.287541Z","steps":["trace[1115343262] 'agreement among raft nodes before linearized reading'  (duration: 131.981843ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:30.828305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.764984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/barbican-api\" ","response":"range_response_count:1 size:7671"}
{"level":"warn","ts":"2026-03-11T19:53:30.828327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.853458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11788"}
{"level":"info","ts":"2026-03-11T19:53:30.828399Z","caller":"traceutil/trace.go:171","msg":"trace[585470751] range","detail":"{range_begin:/registry/deployments/openstack/barbican-api; range_end:; response_count:1; response_revision:11285; }","duration":"115.890706ms","start":"2026-03-11T19:53:30.71248Z","end":"2026-03-11T19:53:30.82837Z","steps":["trace[585470751] 'range keys from in-memory index tree'  (duration: 115.60765ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:30.8284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.601357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-11T19:53:30.828449Z","caller":"traceutil/trace.go:171","msg":"trace[435953971] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:11285; }","duration":"108.027563ms","start":"2026-03-11T19:53:30.720408Z","end":"2026-03-11T19:53:30.828435Z","steps":["trace[435953971] 'range keys from in-memory index tree'  (duration: 107.690414ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:30.828485Z","caller":"traceutil/trace.go:171","msg":"trace[1032717779] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11285; }","duration":"128.74331ms","start":"2026-03-11T19:53:30.69972Z","end":"2026-03-11T19:53:30.828463Z","steps":["trace[1032717779] 'range keys from in-memory index tree'  (duration: 128.406493ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:30.943044Z","caller":"traceutil/trace.go:171","msg":"trace[913628240] transaction","detail":"{read_only:false; response_revision:11286; number_of_response:1; }","duration":"110.620809ms","start":"2026-03-11T19:53:30.832401Z","end":"2026-03-11T19:53:30.943022Z","steps":["trace[913628240] 'process raft request'  (duration: 110.404344ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:38.66549Z","caller":"traceutil/trace.go:171","msg":"trace[997510642] linearizableReadLoop","detail":"{readStateIndex:11751; appliedIndex:11750; }","duration":"153.743564ms","start":"2026-03-11T19:53:38.511722Z","end":"2026-03-11T19:53:38.665465Z","steps":["trace[997510642] 'read index received'  (duration: 153.54035ms)","trace[997510642] 'applied index is now lower than readState.Index'  (duration: 202.424µs)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:53:38.665551Z","caller":"traceutil/trace.go:171","msg":"trace[609580198] transaction","detail":"{read_only:false; response_revision:11323; number_of_response:1; }","duration":"164.327778ms","start":"2026-03-11T19:53:38.501189Z","end":"2026-03-11T19:53:38.665516Z","steps":["trace[609580198] 'process raft request'  (duration: 164.132904ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:38.665758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.5653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:1 size:8412"}
{"level":"info","ts":"2026-03-11T19:53:38.665804Z","caller":"traceutil/trace.go:171","msg":"trace[1860173134] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:1; response_revision:11323; }","duration":"130.662532ms","start":"2026-03-11T19:53:38.53513Z","end":"2026-03-11T19:53:38.665792Z","steps":["trace[1860173134] 'agreement among raft nodes before linearized reading'  (duration: 130.480358ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:38.665792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.059201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-init\" ","response":"range_response_count:1 size:5653"}
{"level":"warn","ts":"2026-03-11T19:53:38.665855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.95209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-03-11T19:53:38.665944Z","caller":"traceutil/trace.go:171","msg":"trace[224344627] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:11323; }","duration":"113.091513ms","start":"2026-03-11T19:53:38.552833Z","end":"2026-03-11T19:53:38.665925Z","steps":["trace[224344627] 'agreement among raft nodes before linearized reading'  (duration: 112.840598ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:38.665873Z","caller":"traceutil/trace.go:171","msg":"trace[1103176600] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-init; range_end:; response_count:1; response_revision:11323; }","duration":"154.214425ms","start":"2026-03-11T19:53:38.51164Z","end":"2026-03-11T19:53:38.665855Z","steps":["trace[1103176600] 'agreement among raft nodes before linearized reading'  (duration: 153.942799ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:38.798343Z","caller":"traceutil/trace.go:171","msg":"trace[2130918722] linearizableReadLoop","detail":"{readStateIndex:11752; appliedIndex:11751; }","duration":"126.954281ms","start":"2026-03-11T19:53:38.67136Z","end":"2026-03-11T19:53:38.798314Z","steps":["trace[2130918722] 'read index received'  (duration: 116.148072ms)","trace[2130918722] 'applied index is now lower than readState.Index'  (duration: 10.805099ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:53:38.798455Z","caller":"traceutil/trace.go:171","msg":"trace[1665614755] transaction","detail":"{read_only:false; response_revision:11324; number_of_response:1; }","duration":"129.176611ms","start":"2026-03-11T19:53:38.669252Z","end":"2026-03-11T19:53:38.798428Z","steps":["trace[1665614755] 'process raft request'  (duration: 118.256179ms)","trace[1665614755] 'compare'  (duration: 10.686367ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T19:53:38.798638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.343358ms","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-03-11T19:53:38.7987Z","caller":"traceutil/trace.go:171","msg":"trace[563357553] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11324; }","duration":"126.426319ms","start":"2026-03-11T19:53:38.672258Z","end":"2026-03-11T19:53:38.798685Z","steps":["trace[563357553] 'agreement among raft nodes before linearized reading'  (duration: 126.248315ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:38.798757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.35721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-init\" ","response":"range_response_count:1 size:5653"}
{"level":"info","ts":"2026-03-11T19:53:38.798862Z","caller":"traceutil/trace.go:171","msg":"trace[1568219287] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-init; range_end:; response_count:1; response_revision:11324; }","duration":"127.497474ms","start":"2026-03-11T19:53:38.67134Z","end":"2026-03-11T19:53:38.798837Z","steps":["trace[1568219287] 'agreement among raft nodes before linearized reading'  (duration: 127.163896ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:38.950094Z","caller":"traceutil/trace.go:171","msg":"trace[1217081114] linearizableReadLoop","detail":"{readStateIndex:11753; appliedIndex:11752; }","duration":"143.899307ms","start":"2026-03-11T19:53:38.806165Z","end":"2026-03-11T19:53:38.950064Z","steps":["trace[1217081114] 'read index received'  (duration: 110.15625ms)","trace[1217081114] 'applied index is now lower than readState.Index'  (duration: 33.741797ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:53:38.950226Z","caller":"traceutil/trace.go:171","msg":"trace[2006489432] transaction","detail":"{read_only:false; response_revision:11325; number_of_response:1; }","duration":"146.74366ms","start":"2026-03-11T19:53:38.803469Z","end":"2026-03-11T19:53:38.950213Z","steps":["trace[2006489432] 'process raft request'  (duration: 112.85716ms)","trace[2006489432] 'compare'  (duration: 33.622804ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T19:53:38.95052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.340656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:1 size:8412"}
{"level":"info","ts":"2026-03-11T19:53:38.950588Z","caller":"traceutil/trace.go:171","msg":"trace[190848939] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:1; response_revision:11325; }","duration":"144.441069ms","start":"2026-03-11T19:53:38.80613Z","end":"2026-03-11T19:53:38.950571Z","steps":["trace[190848939] 'agreement among raft nodes before linearized reading'  (duration: 144.187403ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:38.951536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.503388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/\" range_end:\"/registry/events/openstack0\" limit:500 ","response":"range_response_count:500 size:390304"}
{"level":"info","ts":"2026-03-11T19:53:38.951567Z","caller":"traceutil/trace.go:171","msg":"trace[742598291] range","detail":"{range_begin:/registry/events/openstack/; range_end:/registry/events/openstack0; response_count:500; response_revision:11325; }","duration":"144.55115ms","start":"2026-03-11T19:53:38.807009Z","end":"2026-03-11T19:53:38.95156Z","steps":["trace[742598291] 'agreement among raft nodes before linearized reading'  (duration: 143.250602ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:39.913043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.884562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/staffeln-db-sync\" ","response":"range_response_count:1 size:5127"}
{"level":"info","ts":"2026-03-11T19:53:39.913115Z","caller":"traceutil/trace.go:171","msg":"trace[1613757818] range","detail":"{range_begin:/registry/jobs/openstack/staffeln-db-sync; range_end:; response_count:1; response_revision:11329; }","duration":"305.966755ms","start":"2026-03-11T19:53:39.607129Z","end":"2026-03-11T19:53:39.913096Z","steps":["trace[1613757818] 'range keys from in-memory index tree'  (duration: 305.700928ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:39.913144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T19:53:39.607056Z","time spent":"306.080927ms","remote":"127.0.0.1:41724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":5150,"request content":"key:\"/registry/jobs/openstack/staffeln-db-sync\" "}
{"level":"warn","ts":"2026-03-11T19:53:39.913148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.789461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/monitoring/kube-prometheus-stack-grafana\" ","response":"range_response_count:1 size:1059"}
{"level":"info","ts":"2026-03-11T19:53:39.913203Z","caller":"traceutil/trace.go:171","msg":"trace[1067603390] range","detail":"{range_begin:/registry/rolebindings/monitoring/kube-prometheus-stack-grafana; range_end:; response_count:1; response_revision:11329; }","duration":"300.891972ms","start":"2026-03-11T19:53:39.612298Z","end":"2026-03-11T19:53:39.91319Z","steps":["trace[1067603390] 'range keys from in-memory index tree'  (duration: 300.648477ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:39.913229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T19:53:39.612273Z","time spent":"300.950434ms","remote":"127.0.0.1:41852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":1082,"request content":"key:\"/registry/rolebindings/monitoring/kube-prometheus-stack-grafana\" "}
{"level":"info","ts":"2026-03-11T19:53:39.913363Z","caller":"traceutil/trace.go:171","msg":"trace[1757091965] transaction","detail":"{read_only:false; response_revision:11330; number_of_response:1; }","duration":"298.478839ms","start":"2026-03-11T19:53:39.614877Z","end":"2026-03-11T19:53:39.913356Z","steps":["trace[1757091965] 'process raft request'  (duration: 261.367096ms)","trace[1757091965] 'compare'  (duration: 36.458728ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:53:39.948597Z","caller":"traceutil/trace.go:171","msg":"trace[198595244] linearizableReadLoop","detail":"{readStateIndex:11759; appliedIndex:11757; }","duration":"208.350033ms","start":"2026-03-11T19:53:39.740231Z","end":"2026-03-11T19:53:39.948581Z","steps":["trace[198595244] 'read index received'  (duration: 136.016421ms)","trace[198595244] 'applied index is now lower than readState.Index'  (duration: 72.332762ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T19:53:39.948731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.129187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-03-11T19:53:39.948764Z","caller":"traceutil/trace.go:171","msg":"trace[1350011611] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:11331; }","duration":"142.203329ms","start":"2026-03-11T19:53:39.806549Z","end":"2026-03-11T19:53:39.948752Z","steps":["trace[1350011611] 'agreement among raft nodes before linearized reading'  (duration: 142.143507ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:39.948815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.526217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-11T19:53:39.948937Z","caller":"traceutil/trace.go:171","msg":"trace[253571162] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:11331; }","duration":"208.737441ms","start":"2026-03-11T19:53:39.740175Z","end":"2026-03-11T19:53:39.948913Z","steps":["trace[253571162] 'agreement among raft nodes before linearized reading'  (duration: 208.478906ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:39.949167Z","caller":"traceutil/trace.go:171","msg":"trace[1281026647] transaction","detail":"{read_only:false; response_revision:11331; number_of_response:1; }","duration":"267.190435ms","start":"2026-03-11T19:53:39.68144Z","end":"2026-03-11T19:53:39.948631Z","steps":["trace[1281026647] 'process raft request'  (duration: 267.044392ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:40.465755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.191692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/monitoring/node-feature-discovery-worker\" ","response":"range_response_count:1 size:1093"}
{"level":"info","ts":"2026-03-11T19:53:40.465864Z","caller":"traceutil/trace.go:171","msg":"trace[373821959] range","detail":"{range_begin:/registry/rolebindings/monitoring/node-feature-discovery-worker; range_end:; response_count:1; response_revision:11333; }","duration":"293.357246ms","start":"2026-03-11T19:53:40.17248Z","end":"2026-03-11T19:53:40.465837Z","steps":["trace[373821959] 'range keys from in-memory index tree'  (duration: 292.946266ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:40.465859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.364077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/monitoring/kube-prometheus-stack-grafana\" ","response":"range_response_count:1 size:898"}
{"level":"warn","ts":"2026-03-11T19:53:40.465922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.554306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T19:53:40.465991Z","caller":"traceutil/trace.go:171","msg":"trace[1644372740] range","detail":"{range_begin:/registry/roles/monitoring/kube-prometheus-stack-grafana; range_end:; response_count:1; response_revision:11333; }","duration":"233.539742ms","start":"2026-03-11T19:53:40.232417Z","end":"2026-03-11T19:53:40.465957Z","steps":["trace[1644372740] 'range keys from in-memory index tree'  (duration: 233.05725ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:40.466007Z","caller":"traceutil/trace.go:171","msg":"trace[740312869] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:11333; }","duration":"123.701159ms","start":"2026-03-11T19:53:40.342281Z","end":"2026-03-11T19:53:40.465983Z","steps":["trace[740312869] 'count revisions from in-memory index tree'  (duration: 123.369072ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:40.77888Z","caller":"traceutil/trace.go:171","msg":"trace[1473573293] linearizableReadLoop","detail":"{readStateIndex:11763; appliedIndex:11762; }","duration":"287.997756ms","start":"2026-03-11T19:53:40.490844Z","end":"2026-03-11T19:53:40.778842Z","steps":["trace[1473573293] 'read index received'  (duration: 287.796511ms)","trace[1473573293] 'applied index is now lower than readState.Index'  (duration: 200.015µs)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:53:40.778958Z","caller":"traceutil/trace.go:171","msg":"trace[1624038924] transaction","detail":"{read_only:false; response_revision:11334; number_of_response:1; }","duration":"307.899538ms","start":"2026-03-11T19:53:40.471011Z","end":"2026-03-11T19:53:40.778911Z","steps":["trace[1624038924] 'process raft request'  (duration: 307.61617ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:40.779062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.202101ms","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-03-11T19:53:40.779094Z","caller":"traceutil/trace.go:171","msg":"trace[1414810005] range","detail":"{range_begin:/registry/monitoring.coreos.com/servicemonitors/; range_end:/registry/monitoring.coreos.com/servicemonitors0; response_count:0; response_revision:11334; }","duration":"288.300483ms","start":"2026-03-11T19:53:40.490786Z","end":"2026-03-11T19:53:40.779086Z","steps":["trace[1414810005] 'agreement among raft nodes before linearized reading'  (duration: 288.212692ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:40.779128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T19:53:40.470972Z","time spent":"308.072821ms","remote":"127.0.0.1:41748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:11322 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-11T19:53:40.779404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.002635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/monitoring/kube-prometheus-stack-pod-tls-sidecar\" ","response":"range_response_count:1 size:736"}
{"level":"warn","ts":"2026-03-11T19:53:40.779391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.091794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/monitoring/kube-prometheus-stack-grafana\" ","response":"range_response_count:1 size:898"}
{"level":"info","ts":"2026-03-11T19:53:40.779439Z","caller":"traceutil/trace.go:171","msg":"trace[1640069762] range","detail":"{range_begin:/registry/roles/monitoring/kube-prometheus-stack-pod-tls-sidecar; range_end:; response_count:1; response_revision:11334; }","duration":"203.080257ms","start":"2026-03-11T19:53:40.576352Z","end":"2026-03-11T19:53:40.779432Z","steps":["trace[1640069762] 'agreement among raft nodes before linearized reading'  (duration: 202.960634ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:40.779477Z","caller":"traceutil/trace.go:171","msg":"trace[1940233590] range","detail":"{range_begin:/registry/roles/monitoring/kube-prometheus-stack-grafana; range_end:; response_count:1; response_revision:11334; }","duration":"225.211866ms","start":"2026-03-11T19:53:40.554241Z","end":"2026-03-11T19:53:40.779453Z","steps":["trace[1940233590] 'agreement among raft nodes before linearized reading'  (duration: 224.995122ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:41.013865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.543474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/monitoring/kube-prometheus-stack-pod-tls-sidecar\" ","response":"range_response_count:1 size:736"}
{"level":"info","ts":"2026-03-11T19:53:41.013966Z","caller":"traceutil/trace.go:171","msg":"trace[1862535747] range","detail":"{range_begin:/registry/roles/monitoring/kube-prometheus-stack-pod-tls-sidecar; range_end:; response_count:1; response_revision:11335; }","duration":"146.665477ms","start":"2026-03-11T19:53:40.867278Z","end":"2026-03-11T19:53:41.013943Z","steps":["trace[1862535747] 'range keys from in-memory index tree'  (duration: 146.35455ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:41.217745Z","caller":"traceutil/trace.go:171","msg":"trace[621734216] transaction","detail":"{read_only:false; response_revision:11337; number_of_response:1; }","duration":"198.25518ms","start":"2026-03-11T19:53:41.01946Z","end":"2026-03-11T19:53:41.217715Z","steps":["trace[621734216] 'process raft request'  (duration: 106.901948ms)","trace[621734216] 'compare'  (duration: 90.886282ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T19:53:53.220032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.643686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/openstack/glance-glance-api\" ","response":"range_response_count:1 size:720"}
{"level":"info","ts":"2026-03-11T19:53:53.220141Z","caller":"traceutil/trace.go:171","msg":"trace[1813948830] range","detail":"{range_begin:/registry/rolebindings/openstack/glance-glance-api; range_end:; response_count:1; response_revision:11389; }","duration":"127.80453ms","start":"2026-03-11T19:53:53.092317Z","end":"2026-03-11T19:53:53.220122Z","steps":["trace[1813948830] 'range keys from in-memory index tree'  (duration: 127.398861ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:53.643032Z","caller":"traceutil/trace.go:171","msg":"trace[1563945899] transaction","detail":"{read_only:false; response_revision:11392; number_of_response:1; }","duration":"169.562215ms","start":"2026-03-11T19:53:53.473426Z","end":"2026-03-11T19:53:53.642989Z","steps":["trace[1563945899] 'process raft request'  (duration: 167.943548ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:53.643117Z","caller":"traceutil/trace.go:171","msg":"trace[606033388] linearizableReadLoop","detail":"{readStateIndex:11824; appliedIndex:11822; }","duration":"144.893138ms","start":"2026-03-11T19:53:53.49818Z","end":"2026-03-11T19:53:53.643074Z","steps":["trace[606033388] 'read index received'  (duration: 143.206261ms)","trace[606033388] 'applied index is now lower than readState.Index'  (duration: 1.685307ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:53:53.643203Z","caller":"traceutil/trace.go:171","msg":"trace[108723281] transaction","detail":"{read_only:false; response_revision:11393; number_of_response:1; }","duration":"168.01003ms","start":"2026-03-11T19:53:53.47513Z","end":"2026-03-11T19:53:53.64314Z","steps":["trace[108723281] 'process raft request'  (duration: 167.773285ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:53.643322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.117503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-11T19:53:53.643456Z","caller":"traceutil/trace.go:171","msg":"trace[670289597] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:11393; }","duration":"145.295456ms","start":"2026-03-11T19:53:53.4981Z","end":"2026-03-11T19:53:53.643396Z","steps":["trace[670289597] 'agreement among raft nodes before linearized reading'  (duration: 145.113842ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:53.679839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.667046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/staffeln-db-sync\" ","response":"range_response_count:1 size:5127"}
{"level":"warn","ts":"2026-03-11T19:53:53.679846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.1223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/openstack/glance-glance-ks-endpoints\" ","response":"range_response_count:1 size:756"}
{"level":"info","ts":"2026-03-11T19:53:53.679872Z","caller":"traceutil/trace.go:171","msg":"trace[538490873] transaction","detail":"{read_only:false; response_revision:11394; number_of_response:1; }","duration":"148.967958ms","start":"2026-03-11T19:53:53.530862Z","end":"2026-03-11T19:53:53.67983Z","steps":["trace[538490873] 'process raft request'  (duration: 148.57298ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:53.679928Z","caller":"traceutil/trace.go:171","msg":"trace[1144488445] range","detail":"{range_begin:/registry/jobs/openstack/staffeln-db-sync; range_end:; response_count:1; response_revision:11394; }","duration":"150.82299ms","start":"2026-03-11T19:53:53.529083Z","end":"2026-03-11T19:53:53.679906Z","steps":["trace[1144488445] 'agreement among raft nodes before linearized reading'  (duration: 150.520083ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:53.680059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.435568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/openstack/barbican-openstack-barbican-api\" ","response":"range_response_count:1 size:684"}
{"level":"info","ts":"2026-03-11T19:53:53.680113Z","caller":"traceutil/trace.go:171","msg":"trace[83184034] range","detail":"{range_begin:/registry/roles/openstack/barbican-openstack-barbican-api; range_end:; response_count:1; response_revision:11394; }","duration":"121.554622ms","start":"2026-03-11T19:53:53.558544Z","end":"2026-03-11T19:53:53.680098Z","steps":["trace[83184034] 'agreement among raft nodes before linearized reading'  (duration: 121.365718ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:53.67995Z","caller":"traceutil/trace.go:171","msg":"trace[1422551820] range","detail":"{range_begin:/registry/rolebindings/openstack/glance-glance-ks-endpoints; range_end:; response_count:1; response_revision:11394; }","duration":"120.274773ms","start":"2026-03-11T19:53:53.559648Z","end":"2026-03-11T19:53:53.679923Z","steps":["trace[1422551820] 'agreement among raft nodes before linearized reading'  (duration: 119.966327ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:53:53.680513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.84342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-96k2p\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-03-11T19:53:53.68058Z","caller":"traceutil/trace.go:171","msg":"trace[1685912901] range","detail":"{range_begin:/registry/pods/openstack/keepalived-96k2p; range_end:; response_count:1; response_revision:11394; }","duration":"132.999494ms","start":"2026-03-11T19:53:53.547567Z","end":"2026-03-11T19:53:53.680567Z","steps":["trace[1685912901] 'agreement among raft nodes before linearized reading'  (duration: 132.34679ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:53:57.439806Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10021}
{"level":"info","ts":"2026-03-11T19:53:57.674066Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10021,"took":"232.62373ms","hash":2633612079,"current-db-size-bytes":43044864,"current-db-size":"43 MB","current-db-size-in-use-bytes":16740352,"current-db-size-in-use":"17 MB"}
{"level":"info","ts":"2026-03-11T19:53:57.674129Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2633612079,"revision":10021,"compact-revision":7873}
{"level":"info","ts":"2026-03-11T19:54:00.203763Z","caller":"traceutil/trace.go:171","msg":"trace[1391867679] transaction","detail":"{read_only:false; response_revision:11424; number_of_response:1; }","duration":"109.902674ms","start":"2026-03-11T19:54:00.093821Z","end":"2026-03-11T19:54:00.203724Z","steps":["trace[1391867679] 'process raft request'  (duration: 70.369808ms)","trace[1391867679] 'compare'  (duration: 39.218698ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:54:03.828586Z","caller":"traceutil/trace.go:171","msg":"trace[1452846254] transaction","detail":"{read_only:false; response_revision:11439; number_of_response:1; }","duration":"104.197347ms","start":"2026-03-11T19:54:03.724343Z","end":"2026-03-11T19:54:03.82854Z","steps":["trace[1452846254] 'process raft request'  (duration: 63.374763ms)","trace[1452846254] 'compare'  (duration: 40.674541ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:54:03.82859Z","caller":"traceutil/trace.go:171","msg":"trace[1522651842] linearizableReadLoop","detail":"{readStateIndex:11873; appliedIndex:11872; }","duration":"102.922759ms","start":"2026-03-11T19:54:03.725643Z","end":"2026-03-11T19:54:03.828566Z","steps":["trace[1522651842] 'read index received'  (duration: 62.084315ms)","trace[1522651842] 'applied index is now lower than readState.Index'  (duration: 40.837454ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T19:54:03.829107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.159552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/barbican-api-certs\" ","response":"range_response_count:1 size:4338"}
{"level":"warn","ts":"2026-03-11T19:54:03.829091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.401149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/glance-ks-user\" ","response":"range_response_count:1 size:530"}
{"level":"info","ts":"2026-03-11T19:54:03.829154Z","caller":"traceutil/trace.go:171","msg":"trace[1543754926] range","detail":"{range_begin:/registry/secrets/openstack/barbican-api-certs; range_end:; response_count:1; response_revision:11440; }","duration":"102.270915ms","start":"2026-03-11T19:54:03.726867Z","end":"2026-03-11T19:54:03.829138Z","steps":["trace[1543754926] 'agreement among raft nodes before linearized reading'  (duration: 102.06778ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:54:03.82919Z","caller":"traceutil/trace.go:171","msg":"trace[2107940712] range","detail":"{range_begin:/registry/serviceaccounts/openstack/glance-ks-user; range_end:; response_count:1; response_revision:11440; }","duration":"103.539772ms","start":"2026-03-11T19:54:03.725628Z","end":"2026-03-11T19:54:03.829167Z","steps":["trace[2107940712] 'agreement among raft nodes before linearized reading'  (duration: 102.96702ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T19:54:13.305016Z","caller":"traceutil/trace.go:171","msg":"trace[1452541701] linearizableReadLoop","detail":"{readStateIndex:11917; appliedIndex:11916; }","duration":"124.68652ms","start":"2026-03-11T19:54:13.180306Z","end":"2026-03-11T19:54:13.304993Z","steps":["trace[1452541701] 'read index received'  (duration: 124.480235ms)","trace[1452541701] 'applied index is now lower than readState.Index'  (duration: 205.395µs)"],"step_count":2}
{"level":"info","ts":"2026-03-11T19:54:13.305071Z","caller":"traceutil/trace.go:171","msg":"trace[1284245081] transaction","detail":"{read_only:false; response_revision:11481; number_of_response:1; }","duration":"130.662513ms","start":"2026-03-11T19:54:13.174378Z","end":"2026-03-11T19:54:13.305041Z","steps":["trace[1284245081] 'process raft request'  (duration: 130.484579ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:54:13.305243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.930996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/sh.helm.release.v1.keystone.v1\" ","response":"range_response_count:1 size:72272"}
{"level":"info","ts":"2026-03-11T19:54:13.305284Z","caller":"traceutil/trace.go:171","msg":"trace[570233127] range","detail":"{range_begin:/registry/secrets/openstack/sh.helm.release.v1.keystone.v1; range_end:; response_count:1; response_revision:11481; }","duration":"125.033528ms","start":"2026-03-11T19:54:13.18024Z","end":"2026-03-11T19:54:13.305274Z","steps":["trace[570233127] 'agreement among raft nodes before linearized reading'  (duration: 124.868444ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:54:15.544161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.051813ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827830396718902022 > lease_revoke:<id:50e09cde5fa767e1>","response":"size:28"}
{"level":"info","ts":"2026-03-11T19:54:15.544255Z","caller":"traceutil/trace.go:171","msg":"trace[253623152] linearizableReadLoop","detail":"{readStateIndex:11928; appliedIndex:11927; }","duration":"116.567351ms","start":"2026-03-11T19:54:15.427671Z","end":"2026-03-11T19:54:15.544239Z","steps":["trace[253623152] 'read index received'  (duration: 53.411µs)","trace[253623152] 'applied index is now lower than readState.Index'  (duration: 116.51249ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T19:54:15.544566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.880148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-haproxy-metrics\" ","response":"range_response_count:1 size:797"}
{"level":"info","ts":"2026-03-11T19:54:15.544656Z","caller":"traceutil/trace.go:171","msg":"trace[1848942539] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-haproxy-metrics; range_end:; response_count:1; response_revision:11491; }","duration":"117.009711ms","start":"2026-03-11T19:54:15.427622Z","end":"2026-03-11T19:54:15.544632Z","steps":["trace[1848942539] 'agreement among raft nodes before linearized reading'  (duration: 116.763716ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:54:15.544885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.650358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-haproxy-replicas\" ","response":"range_response_count:1 size:2112"}
{"level":"info","ts":"2026-03-11T19:54:15.544929Z","caller":"traceutil/trace.go:171","msg":"trace[1769336466] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-haproxy-replicas; range_end:; response_count:1; response_revision:11491; }","duration":"114.73053ms","start":"2026-03-11T19:54:15.430186Z","end":"2026-03-11T19:54:15.544916Z","steps":["trace[1769336466] 'agreement among raft nodes before linearized reading'  (duration: 114.286761ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T19:54:27.61737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.30256ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827830396718902591 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:11539 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-11T19:54:27.617758Z","caller":"traceutil/trace.go:171","msg":"trace[1050899964] transaction","detail":"{read_only:false; response_revision:11547; number_of_response:1; }","duration":"141.178955ms","start":"2026-03-11T19:54:27.476444Z","end":"2026-03-11T19:54:27.617623Z","steps":["trace[1050899964] 'process raft request'  (duration: 31.534338ms)","trace[1050899964] 'compare'  (duration: 109.152327ms)"],"step_count":2}