{"level":"warn","ts":"2026-07-13T20:02:47.849134Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-07-13T20:02:47.849234Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.38: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.38:2380","--initial-cluster=instance=https://199.204.45.38:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.38:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.38: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-07-13T20:02:47.849322Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-07-13T20:02:47.849336Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.38:2380"]}
{"level":"info","ts":"2026-07-13T20:02:47.849369Z","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-07-13T20:02:47.850063Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"]}
{"level":"info","ts":"2026-07-13T20:02:47.85016Z","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.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.38: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-07-13T20:02:47.854089Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.6863ms"}
{"level":"info","ts":"2026-07-13T20:02:47.86422Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"331455d6226d3423","cluster-id":"25c7803fb83a1455"}
{"level":"info","ts":"2026-07-13T20:02:47.864326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=()"}
{"level":"info","ts":"2026-07-13T20:02:47.86439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 0"}
{"level":"info","ts":"2026-07-13T20:02:47.864421Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 331455d6226d3423 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-07-13T20:02:47.864468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 1"}
{"level":"info","ts":"2026-07-13T20:02:47.86458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"}
{"level":"warn","ts":"2026-07-13T20:02:47.874078Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-07-13T20:02:47.87544Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-07-13T20:02:47.876486Z","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-07-13T20:02:47.87856Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"331455d6226d3423","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-07-13T20:02:47.878688Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"331455d6226d3423","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-07-13T20:02:47.878768Z","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-07-13T20:02:47.878848Z","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-07-13T20:02:47.878858Z","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-07-13T20:02:47.879752Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"}
{"level":"info","ts":"2026-07-13T20:02:47.881091Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","added-peer-id":"331455d6226d3423","added-peer-peer-urls":["https://199.204.45.38:2380"]}
{"level":"info","ts":"2026-07-13T20:02:47.882639Z","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-07-13T20:02:47.882721Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.38:2380"}
{"level":"info","ts":"2026-07-13T20:02:47.882758Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.38:2380"}
{"level":"info","ts":"2026-07-13T20:02:47.882895Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"331455d6226d3423","initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-07-13T20:02:47.882927Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-07-13T20:02:48.665976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 is starting a new election at term 1"}
{"level":"info","ts":"2026-07-13T20:02:48.66608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became pre-candidate at term 1"}
{"level":"info","ts":"2026-07-13T20:02:48.666118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgPreVoteResp from 331455d6226d3423 at term 1"}
{"level":"info","ts":"2026-07-13T20:02:48.66614Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became candidate at term 2"}
{"level":"info","ts":"2026-07-13T20:02:48.666152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgVoteResp from 331455d6226d3423 at term 2"}
{"level":"info","ts":"2026-07-13T20:02:48.66617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became leader at term 2"}
{"level":"info","ts":"2026-07-13T20:02:48.666186Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 331455d6226d3423 elected leader 331455d6226d3423 at term 2"}
{"level":"info","ts":"2026-07-13T20:02:48.667379Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-13T20:02:48.668284Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"331455d6226d3423","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.38:2379]}","request-path":"/0/members/331455d6226d3423/attributes","cluster-id":"25c7803fb83a1455","publish-timeout":"7s"}
{"level":"info","ts":"2026-07-13T20:02:48.668332Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-07-13T20:02:48.668384Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-07-13T20:02:48.668642Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-07-13T20:02:48.668728Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-07-13T20:02:48.668923Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-13T20:02:48.669054Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-13T20:02:48.669101Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-13T20:02:48.671954Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.38:2379"}
{"level":"info","ts":"2026-07-13T20:02:48.672329Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-07-13T20:03:23.510655Z","caller":"traceutil/trace.go:171","msg":"trace[1958689623] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"113.781123ms","start":"2026-07-13T20:03:23.396797Z","end":"2026-07-13T20:03:23.510578Z","steps":["trace[1958689623] 'process raft request'  (duration: 113.120907ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:03:23.521247Z","caller":"traceutil/trace.go:171","msg":"trace[357591196] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"118.606961ms","start":"2026-07-13T20:03:23.402619Z","end":"2026-07-13T20:03:23.521226Z","steps":["trace[357591196] 'process raft request'  (duration: 118.414136ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:03:23.521499Z","caller":"traceutil/trace.go:171","msg":"trace[1339788073] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"107.633901ms","start":"2026-07-13T20:03:23.413857Z","end":"2026-07-13T20:03:23.521491Z","steps":["trace[1339788073] 'process raft request'  (duration: 107.368755ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:03:23.521563Z","caller":"traceutil/trace.go:171","msg":"trace[782843597] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"115.389552ms","start":"2026-07-13T20:03:23.406136Z","end":"2026-07-13T20:03:23.521526Z","steps":["trace[782843597] 'process raft request'  (duration: 115.025993ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:03:23.521787Z","caller":"traceutil/trace.go:171","msg":"trace[904176660] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"102.235279ms","start":"2026-07-13T20:03:23.419538Z","end":"2026-07-13T20:03:23.521773Z","steps":["trace[904176660] 'process raft request'  (duration: 101.757038ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:03:29.757335Z","caller":"traceutil/trace.go:171","msg":"trace[398782008] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:645; }","duration":"149.293195ms","start":"2026-07-13T20:03:29.608018Z","end":"2026-07-13T20:03:29.757311Z","steps":["trace[398782008] 'read index received'  (duration: 149.104521ms)","trace[398782008] 'applied index is now lower than readState.Index'  (duration: 187.794µs)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:03:29.757408Z","caller":"traceutil/trace.go:171","msg":"trace[935562464] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"188.651521ms","start":"2026-07-13T20:03:29.568719Z","end":"2026-07-13T20:03:29.75737Z","steps":["trace[935562464] 'process raft request'  (duration: 188.453796ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:03:29.757599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.559651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-77dpc\" ","response":"range_response_count:1 size:16961"}
{"level":"info","ts":"2026-07-13T20:03:29.757653Z","caller":"traceutil/trace.go:171","msg":"trace[1790905766] range","detail":"{range_begin:/registry/pods/kube-system/cilium-77dpc; range_end:; response_count:1; response_revision:628; }","duration":"149.679484ms","start":"2026-07-13T20:03:29.607963Z","end":"2026-07-13T20:03:29.757643Z","steps":["trace[1790905766] 'agreement among raft nodes before linearized reading'  (duration: 149.49854ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:03:30.014564Z","caller":"traceutil/trace.go:171","msg":"trace[31960025] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"240.515735ms","start":"2026-07-13T20:03:29.774016Z","end":"2026-07-13T20:03:30.014531Z","steps":["trace[31960025] 'process raft request'  (duration: 189.205346ms)","trace[31960025] 'compare'  (duration: 51.114124ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:03:30.019613Z","caller":"traceutil/trace.go:171","msg":"trace[689674270] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"224.890171ms","start":"2026-07-13T20:03:29.794698Z","end":"2026-07-13T20:03:30.019589Z","steps":["trace[689674270] 'process raft request'  (duration: 224.171053ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:03:30.47599Z","caller":"traceutil/trace.go:171","msg":"trace[1619464032] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"378.410129ms","start":"2026-07-13T20:03:30.097551Z","end":"2026-07-13T20:03:30.475961Z","steps":["trace[1619464032] 'read index received'  (duration: 373.964499ms)","trace[1619464032] 'applied index is now lower than readState.Index'  (duration: 4.44442ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-13T20:03:30.47598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.289804ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-13T20:03:30.476128Z","caller":"traceutil/trace.go:171","msg":"trace[1541964929] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:630; }","duration":"285.472888ms","start":"2026-07-13T20:03:30.190634Z","end":"2026-07-13T20:03:30.476107Z","steps":["trace[1541964929] 'range keys from in-memory index tree'  (duration: 285.265123ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:03:30.47619Z","caller":"traceutil/trace.go:171","msg":"trace[1083089793] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"402.724796ms","start":"2026-07-13T20:03:30.073421Z","end":"2026-07-13T20:03:30.476146Z","steps":["trace[1083089793] 'process raft request'  (duration: 398.207895ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:03:30.476216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.643635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-07-13T20:03:30.476254Z","caller":"traceutil/trace.go:171","msg":"trace[501110324] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:631; }","duration":"378.774967ms","start":"2026-07-13T20:03:30.09747Z","end":"2026-07-13T20:03:30.476245Z","steps":["trace[501110324] 'agreement among raft nodes before linearized reading'  (duration: 378.584573ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:03:30.476285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:03:30.097454Z","time spent":"378.822939ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-07-13T20:03:30.476806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:03:30.073398Z","time spent":"402.847709ms","remote":"127.0.0.1:42480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" mod_revision:0 > success:<request_put:<key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" value_size:2525 >> failure:<>"}
{"level":"info","ts":"2026-07-13T20:03:32.021394Z","caller":"traceutil/trace.go:171","msg":"trace[1112905500] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"148.488235ms","start":"2026-07-13T20:03:31.872884Z","end":"2026-07-13T20:03:32.021372Z","steps":["trace[1112905500] 'process raft request'  (duration: 148.381972ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:03:43.805305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.543265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-k6wmd\" ","response":"range_response_count:1 size:3964"}
{"level":"info","ts":"2026-07-13T20:03:43.805404Z","caller":"traceutil/trace.go:171","msg":"trace[1950916023] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-k6wmd; range_end:; response_count:1; response_revision:782; }","duration":"106.693978ms","start":"2026-07-13T20:03:43.698687Z","end":"2026-07-13T20:03:43.805381Z","steps":["trace[1950916023] 'range keys from in-memory index tree'  (duration: 106.32435ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:03:43.947677Z","caller":"traceutil/trace.go:171","msg":"trace[1683887377] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"138.797077ms","start":"2026-07-13T20:03:43.808863Z","end":"2026-07-13T20:03:43.94766Z","steps":["trace[1683887377] 'process raft request'  (duration: 138.667394ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:03:43.988883Z","caller":"traceutil/trace.go:171","msg":"trace[965301918] linearizableReadLoop","detail":"{readStateIndex:806; appliedIndex:805; }","duration":"119.167666ms","start":"2026-07-13T20:03:43.869692Z","end":"2026-07-13T20:03:43.98886Z","steps":["trace[965301918] 'read index received'  (duration: 77.981745ms)","trace[965301918] 'applied index is now lower than readState.Index'  (duration: 41.184801ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-13T20:03:43.989115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.386871ms","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-07-13T20:03:43.989183Z","caller":"traceutil/trace.go:171","msg":"trace[1650990887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:784; }","duration":"119.520895ms","start":"2026-07-13T20:03:43.869647Z","end":"2026-07-13T20:03:43.989168Z","steps":["trace[1650990887] 'agreement among raft nodes before linearized reading'  (duration: 119.31907ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:03:43.98906Z","caller":"traceutil/trace.go:171","msg":"trace[937116858] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"176.3833ms","start":"2026-07-13T20:03:43.812618Z","end":"2026-07-13T20:03:43.989001Z","steps":["trace[937116858] 'process raft request'  (duration: 176.086342ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:04:37.128175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.676033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-07-13T20:04:37.128273Z","caller":"traceutil/trace.go:171","msg":"trace[402325892] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1451; }","duration":"118.827537ms","start":"2026-07-13T20:04:37.009425Z","end":"2026-07-13T20:04:37.128252Z","steps":["trace[402325892] 'range keys from in-memory index tree'  (duration: 118.490177ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:04:37.141117Z","caller":"traceutil/trace.go:171","msg":"trace[108288538] linearizableReadLoop","detail":"{readStateIndex:1492; appliedIndex:1491; }","duration":"110.392629ms","start":"2026-07-13T20:04:37.030704Z","end":"2026-07-13T20:04:37.141097Z","steps":["trace[108288538] 'read index received'  (duration: 96.530171ms)","trace[108288538] 'applied index is now lower than readState.Index'  (duration: 13.861118ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-13T20:04:37.141283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.569734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-07-13T20:04:37.141309Z","caller":"traceutil/trace.go:171","msg":"trace[625960036] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1451; }","duration":"110.651996ms","start":"2026-07-13T20:04:37.03065Z","end":"2026-07-13T20:04:37.141302Z","steps":["trace[625960036] 'agreement among raft nodes before linearized reading'  (duration: 110.524143ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:05:00.616875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.32114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-07-13T20:05:00.616933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.69824ms","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-07-13T20:05:00.617018Z","caller":"traceutil/trace.go:171","msg":"trace[1562338241] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1863; }","duration":"282.826532ms","start":"2026-07-13T20:05:00.334171Z","end":"2026-07-13T20:05:00.616997Z","steps":["trace[1562338241] 'range keys from in-memory index tree'  (duration: 282.498185ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:05:00.617119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.502938ms","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-07-13T20:05:00.617235Z","caller":"traceutil/trace.go:171","msg":"trace[275777632] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1863; }","duration":"292.689202ms","start":"2026-07-13T20:05:00.324515Z","end":"2026-07-13T20:05:00.617205Z","steps":["trace[275777632] 'range keys from in-memory index tree'  (duration: 292.241162ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:05:00.617294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.455405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cce0cc3f-c2a3-448d-a2f1-2c758f1f7d69\" ","response":"range_response_count:1 size:3626"}
{"level":"info","ts":"2026-07-13T20:05:00.617321Z","caller":"traceutil/trace.go:171","msg":"trace[107418865] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cce0cc3f-c2a3-448d-a2f1-2c758f1f7d69; range_end:; response_count:1; response_revision:1863; }","duration":"200.519276ms","start":"2026-07-13T20:05:00.416793Z","end":"2026-07-13T20:05:00.617313Z","steps":["trace[107418865] 'range keys from in-memory index tree'  (duration: 200.266061ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:05:00.616959Z","caller":"traceutil/trace.go:171","msg":"trace[160847237] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1863; }","duration":"291.461163ms","start":"2026-07-13T20:05:00.325482Z","end":"2026-07-13T20:05:00.616944Z","steps":["trace[160847237] 'range keys from in-memory index tree'  (duration: 291.242878ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:05:39.012395Z","caller":"traceutil/trace.go:171","msg":"trace[349349678] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"125.239244ms","start":"2026-07-13T20:05:38.887125Z","end":"2026-07-13T20:05:39.012364Z","steps":["trace[349349678] 'process raft request'  (duration: 83.196639ms)","trace[349349678] 'compare'  (duration: 41.931412ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:05:51.054834Z","caller":"traceutil/trace.go:171","msg":"trace[1791021737] linearizableReadLoop","detail":"{readStateIndex:2263; appliedIndex:2262; }","duration":"151.289549ms","start":"2026-07-13T20:05:50.903518Z","end":"2026-07-13T20:05:51.054807Z","steps":["trace[1791021737] 'read index received'  (duration: 151.183506ms)","trace[1791021737] 'applied index is now lower than readState.Index'  (duration: 104.773µs)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:05:51.054952Z","caller":"traceutil/trace.go:171","msg":"trace[964576469] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"228.294846ms","start":"2026-07-13T20:05:50.826625Z","end":"2026-07-13T20:05:51.05492Z","steps":["trace[964576469] 'process raft request'  (duration: 228.02831ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:05:51.055187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.646117ms","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-07-13T20:05:51.055278Z","caller":"traceutil/trace.go:171","msg":"trace[184103163] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2186; }","duration":"151.798221ms","start":"2026-07-13T20:05:50.903461Z","end":"2026-07-13T20:05:51.055259Z","steps":["trace[184103163] 'agreement among raft nodes before linearized reading'  (duration: 151.480763ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:05:51.543937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.196805ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757021736260192941 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2178 > 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-07-13T20:05:51.544132Z","caller":"traceutil/trace.go:171","msg":"trace[2084064421] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"319.171032ms","start":"2026-07-13T20:05:51.224943Z","end":"2026-07-13T20:05:51.544114Z","steps":["trace[2084064421] 'process raft request'  (duration: 319.105021ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:05:51.544213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:05:51.224927Z","time spent":"319.249654ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2180 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-07-13T20:05:51.544229Z","caller":"traceutil/trace.go:171","msg":"trace[1380553432] linearizableReadLoop","detail":"{readStateIndex:2265; appliedIndex:2264; }","duration":"337.013897ms","start":"2026-07-13T20:05:51.20719Z","end":"2026-07-13T20:05:51.544204Z","steps":["trace[1380553432] 'read index received'  (duration: 37.174077ms)","trace[1380553432] 'applied index is now lower than readState.Index'  (duration: 299.83738ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:05:51.544091Z","caller":"traceutil/trace.go:171","msg":"trace[1629807217] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"444.411616ms","start":"2026-07-13T20:05:51.099644Z","end":"2026-07-13T20:05:51.544055Z","steps":["trace[1629807217] 'process raft request'  (duration: 144.714158ms)","trace[1629807217] 'compare'  (duration: 299.061041ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-13T20:05:51.544604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:05:51.099618Z","time spent":"444.886418ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2178 > 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-07-13T20:05:51.545244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.054953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-07-13T20:05:51.545314Z","caller":"traceutil/trace.go:171","msg":"trace[1908836097] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2189; }","duration":"338.153345ms","start":"2026-07-13T20:05:51.207143Z","end":"2026-07-13T20:05:51.545296Z","steps":["trace[1908836097] 'agreement among raft nodes before linearized reading'  (duration: 337.354285ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:05:51.545366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:05:51.207127Z","time spent":"338.227307ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-07-13T20:05:51.572347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.48492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-13T20:05:51.572421Z","caller":"traceutil/trace.go:171","msg":"trace[1004371327] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2190; }","duration":"246.558272ms","start":"2026-07-13T20:05:51.325846Z","end":"2026-07-13T20:05:51.572404Z","steps":["trace[1004371327] 'agreement among raft nodes before linearized reading'  (duration: 246.450029ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:05:51.57241Z","caller":"traceutil/trace.go:171","msg":"trace[1064780959] transaction","detail":"{read_only:false; response_revision:2190; number_of_response:1; }","duration":"129.20526ms","start":"2026-07-13T20:05:51.443164Z","end":"2026-07-13T20:05:51.572369Z","steps":["trace[1064780959] 'process raft request'  (duration: 129.015495ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:06:39.447612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.714884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-07-13T20:06:39.447648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.197014ms","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-07-13T20:06:39.447697Z","caller":"traceutil/trace.go:171","msg":"trace[1402550907] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2620; }","duration":"122.811927ms","start":"2026-07-13T20:06:39.324868Z","end":"2026-07-13T20:06:39.44768Z","steps":["trace[1402550907] 'range keys from in-memory index tree'  (duration: 122.639603ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:06:39.447735Z","caller":"traceutil/trace.go:171","msg":"trace[1225909438] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2620; }","duration":"134.332978ms","start":"2026-07-13T20:06:39.313385Z","end":"2026-07-13T20:06:39.447718Z","steps":["trace[1225909438] 'range keys from in-memory index tree'  (duration: 134.01576ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:07:13.74134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.279391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-07-13T20:07:13.741435Z","caller":"traceutil/trace.go:171","msg":"trace[895223446] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2826; }","duration":"117.424415ms","start":"2026-07-13T20:07:13.62399Z","end":"2026-07-13T20:07:13.741415Z","steps":["trace[895223446] 'range keys from in-memory index tree'  (duration: 117.084817ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:09:38.569257Z","caller":"traceutil/trace.go:171","msg":"trace[703626917] transaction","detail":"{read_only:false; response_revision:3793; number_of_response:1; }","duration":"108.918513ms","start":"2026-07-13T20:09:38.460304Z","end":"2026-07-13T20:09:38.569222Z","steps":["trace[703626917] 'process raft request'  (duration: 108.712988ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:11:04.26304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.963768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:1219"}
{"level":"info","ts":"2026-07-13T20:11:04.263133Z","caller":"traceutil/trace.go:171","msg":"trace[451314628] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4961; }","duration":"114.120482ms","start":"2026-07-13T20:11:04.148992Z","end":"2026-07-13T20:11:04.263113Z","steps":["trace[451314628] 'range keys from in-memory index tree'  (duration: 113.792384ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:11:18.345026Z","caller":"traceutil/trace.go:171","msg":"trace[1408934279] linearizableReadLoop","detail":"{readStateIndex:5417; appliedIndex:5416; }","duration":"229.095385ms","start":"2026-07-13T20:11:18.115909Z","end":"2026-07-13T20:11:18.345004Z","steps":["trace[1408934279] 'read index received'  (duration: 229.015213ms)","trace[1408934279] 'applied index is now lower than readState.Index'  (duration: 78.992µs)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:11:18.345103Z","caller":"traceutil/trace.go:171","msg":"trace[1115686186] transaction","detail":"{read_only:false; response_revision:5224; number_of_response:1; }","duration":"252.390742ms","start":"2026-07-13T20:11:18.092671Z","end":"2026-07-13T20:11:18.345062Z","steps":["trace[1115686186] 'process raft request'  (duration: 252.186708ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:11:18.345201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.274479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-13T20:11:18.345247Z","caller":"traceutil/trace.go:171","msg":"trace[1688568568] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:5224; }","duration":"229.357992ms","start":"2026-07-13T20:11:18.115875Z","end":"2026-07-13T20:11:18.345233Z","steps":["trace[1688568568] 'agreement among raft nodes before linearized reading'  (duration: 229.270529ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:11:18.346502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.848784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/memcached-metrics\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-13T20:11:18.346625Z","caller":"traceutil/trace.go:171","msg":"trace[289888545] range","detail":"{range_begin:/registry/services/specs/openstack/memcached-metrics; range_end:; response_count:0; response_revision:5225; }","duration":"141.254043ms","start":"2026-07-13T20:11:18.205345Z","end":"2026-07-13T20:11:18.346599Z","steps":["trace[289888545] 'agreement among raft nodes before linearized reading'  (duration: 140.802392ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:11:18.346949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.919652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-13T20:11:18.347052Z","caller":"traceutil/trace.go:171","msg":"trace[1408878501] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:5225; }","duration":"129.027445ms","start":"2026-07-13T20:11:18.217972Z","end":"2026-07-13T20:11:18.346999Z","steps":["trace[1408878501] 'agreement among raft nodes before linearized reading'  (duration: 128.932653ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:11:26.381233Z","caller":"traceutil/trace.go:171","msg":"trace[820900005] linearizableReadLoop","detail":"{readStateIndex:5619; appliedIndex:5618; }","duration":"145.652651ms","start":"2026-07-13T20:11:26.235563Z","end":"2026-07-13T20:11:26.381215Z","steps":["trace[820900005] 'read index received'  (duration: 135.265538ms)","trace[820900005] 'applied index is now lower than readState.Index'  (duration: 10.386303ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:11:26.381399Z","caller":"traceutil/trace.go:171","msg":"trace[531750532] transaction","detail":"{read_only:false; response_revision:5424; number_of_response:1; }","duration":"146.753549ms","start":"2026-07-13T20:11:26.234625Z","end":"2026-07-13T20:11:26.381379Z","steps":["trace[531750532] 'process raft request'  (duration: 136.261162ms)","trace[531750532] 'compare'  (duration: 10.221749ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-13T20:11:26.381427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.946809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-13T20:11:26.381467Z","caller":"traceutil/trace.go:171","msg":"trace[1867309296] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:0; response_revision:5424; }","duration":"144.000921ms","start":"2026-07-13T20:11:26.237454Z","end":"2026-07-13T20:11:26.381455Z","steps":["trace[1867309296] 'agreement among raft nodes before linearized reading'  (duration: 143.912888ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:11:26.38149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.934029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:16 size:111441"}
{"level":"info","ts":"2026-07-13T20:11:26.38152Z","caller":"traceutil/trace.go:171","msg":"trace[1449928017] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:16; response_revision:5424; }","duration":"146.010401ms","start":"2026-07-13T20:11:26.235503Z","end":"2026-07-13T20:11:26.381514Z","steps":["trace[1449928017] 'agreement among raft nodes before linearized reading'  (duration: 145.771704ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:11:26.746951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.818777ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757021736260200504 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" mod_revision:0 > success:<request_put:<key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" value_size:4690 >> failure:<request_range:<key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" > >>","response":"size:16"}
{"level":"info","ts":"2026-07-13T20:11:26.747184Z","caller":"traceutil/trace.go:171","msg":"trace[39870658] transaction","detail":"{read_only:false; response_revision:5426; number_of_response:1; }","duration":"327.992905ms","start":"2026-07-13T20:11:26.419172Z","end":"2026-07-13T20:11:26.747165Z","steps":["trace[39870658] 'process raft request'  (duration: 327.914684ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:11:26.747264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:11:26.41915Z","time spent":"328.078087ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5329 > 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-07-13T20:11:26.74726Z","caller":"traceutil/trace.go:171","msg":"trace[273508542] linearizableReadLoop","detail":"{readStateIndex:5620; appliedIndex:5619; }","duration":"351.048187ms","start":"2026-07-13T20:11:26.396144Z","end":"2026-07-13T20:11:26.747193Z","steps":["trace[273508542] 'read index received'  (duration: 110.832921ms)","trace[273508542] 'applied index is now lower than readState.Index'  (duration: 240.212976ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:11:26.747434Z","caller":"traceutil/trace.go:171","msg":"trace[22875396] transaction","detail":"{read_only:false; response_revision:5425; number_of_response:1; }","duration":"361.374249ms","start":"2026-07-13T20:11:26.386045Z","end":"2026-07-13T20:11:26.74742Z","steps":["trace[22875396] 'process raft request'  (duration: 120.987319ms)","trace[22875396] 'compare'  (duration: 239.645132ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-13T20:11:26.747563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:11:26.38602Z","time spent":"361.488102ms","remote":"127.0.0.1:42344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4776,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" mod_revision:0 > success:<request_put:<key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" value_size:4690 >> failure:<request_range:<key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" > >"}
{"level":"warn","ts":"2026-07-13T20:11:26.747713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.532939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4866"}
{"level":"info","ts":"2026-07-13T20:11:26.747806Z","caller":"traceutil/trace.go:171","msg":"trace[253098755] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:5426; }","duration":"351.669472ms","start":"2026-07-13T20:11:26.396114Z","end":"2026-07-13T20:11:26.747783Z","steps":["trace[253098755] 'agreement among raft nodes before linearized reading'  (duration: 351.399236ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:11:26.747858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:11:26.3961Z","time spent":"351.748574ms","remote":"127.0.0.1:55420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":4888,"request content":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" "}
{"level":"info","ts":"2026-07-13T20:11:26.837651Z","caller":"traceutil/trace.go:171","msg":"trace[13640177] transaction","detail":"{read_only:false; response_revision:5428; number_of_response:1; }","duration":"125.125129ms","start":"2026-07-13T20:11:26.712495Z","end":"2026-07-13T20:11:26.837621Z","steps":["trace[13640177] 'process raft request'  (duration: 124.848512ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:11:26.837728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.989541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-g8sjv\" ","response":"range_response_count:1 size:6527"}
{"level":"info","ts":"2026-07-13T20:11:26.837906Z","caller":"traceutil/trace.go:171","msg":"trace[860163855] range","detail":"{range_begin:/registry/pods/openstack/keepalived-g8sjv; range_end:; response_count:1; response_revision:5428; }","duration":"373.202607ms","start":"2026-07-13T20:11:26.464676Z","end":"2026-07-13T20:11:26.837878Z","steps":["trace[860163855] 'agreement among raft nodes before linearized reading'  (duration: 372.859729ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:11:26.838046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:11:26.464664Z","time spent":"373.33186ms","remote":"127.0.0.1:42444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6549,"request content":"key:\"/registry/pods/openstack/keepalived-g8sjv\" "}
{"level":"warn","ts":"2026-07-13T20:11:26.838482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.027335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2224956"}
{"level":"info","ts":"2026-07-13T20:11:26.838567Z","caller":"traceutil/trace.go:171","msg":"trace[531980082] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:5428; }","duration":"442.135777ms","start":"2026-07-13T20:11:26.396412Z","end":"2026-07-13T20:11:26.838548Z","steps":["trace[531980082] 'agreement among raft nodes before linearized reading'  (duration: 441.114942ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:11:26.838614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:11:26.396407Z","time spent":"442.19533ms","remote":"127.0.0.1:42358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":57,"response size":2224978,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "}
{"level":"info","ts":"2026-07-13T20:11:26.863533Z","caller":"traceutil/trace.go:171","msg":"trace[1282495725] transaction","detail":"{read_only:false; response_revision:5429; number_of_response:1; }","duration":"106.188378ms","start":"2026-07-13T20:11:26.757308Z","end":"2026-07-13T20:11:26.863496Z","steps":["trace[1282495725] 'process raft request'  (duration: 105.510841ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:11:26.863555Z","caller":"traceutil/trace.go:171","msg":"trace[923634345] transaction","detail":"{read_only:false; number_of_response:1; response_revision:5429; }","duration":"104.357125ms","start":"2026-07-13T20:11:26.759143Z","end":"2026-07-13T20:11:26.8635Z","steps":["trace[923634345] 'process raft request'  (duration: 104.265862ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:11:26.863762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.997886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"}
{"level":"info","ts":"2026-07-13T20:11:26.863874Z","caller":"traceutil/trace.go:171","msg":"trace[1086291386] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:5429; }","duration":"111.16116ms","start":"2026-07-13T20:11:26.752696Z","end":"2026-07-13T20:11:26.863857Z","steps":["trace[1086291386] 'agreement among raft nodes before linearized reading'  (duration: 110.793641ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:12:18.512372Z","caller":"traceutil/trace.go:171","msg":"trace[963827557] linearizableReadLoop","detail":"{readStateIndex:6122; appliedIndex:6121; }","duration":"107.845412ms","start":"2026-07-13T20:12:18.404503Z","end":"2026-07-13T20:12:18.512348Z","steps":["trace[963827557] 'read index received'  (duration: 107.647786ms)","trace[963827557] 'applied index is now lower than readState.Index'  (duration: 196.826µs)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:12:18.512429Z","caller":"traceutil/trace.go:171","msg":"trace[1619596305] transaction","detail":"{read_only:false; response_revision:5912; number_of_response:1; }","duration":"111.024689ms","start":"2026-07-13T20:12:18.401368Z","end":"2026-07-13T20:12:18.512393Z","steps":["trace[1619596305] 'process raft request'  (duration: 110.830283ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:12:18.512709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.17803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:16 size:111929"}
{"level":"info","ts":"2026-07-13T20:12:18.512757Z","caller":"traceutil/trace.go:171","msg":"trace[1287498398] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:16; response_revision:5912; }","duration":"108.270112ms","start":"2026-07-13T20:12:18.404476Z","end":"2026-07-13T20:12:18.512746Z","steps":["trace[1287498398] 'agreement among raft nodes before linearized reading'  (duration: 107.984435ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:12:48.694857Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3023}
{"level":"info","ts":"2026-07-13T20:12:48.772463Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3023,"took":"76.035245ms","hash":2444020702,"current-db-size-bytes":58331136,"current-db-size":"58 MB","current-db-size-in-use-bytes":32292864,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-07-13T20:12:48.772533Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2444020702,"revision":3023,"compact-revision":-1}
{"level":"warn","ts":"2026-07-13T20:17:35.165428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.494906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-g8sjv\" ","response":"range_response_count:1 size:6527"}
{"level":"info","ts":"2026-07-13T20:17:35.165564Z","caller":"traceutil/trace.go:171","msg":"trace[931217734] range","detail":"{range_begin:/registry/pods/openstack/keepalived-g8sjv; range_end:; response_count:1; response_revision:8249; }","duration":"209.675311ms","start":"2026-07-13T20:17:34.955863Z","end":"2026-07-13T20:17:35.165538Z","steps":["trace[931217734] 'range keys from in-memory index tree'  (duration: 209.311322ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:17:47.314067Z","caller":"traceutil/trace.go:171","msg":"trace[1498583247] transaction","detail":"{read_only:false; response_revision:8312; number_of_response:1; }","duration":"231.293489ms","start":"2026-07-13T20:17:47.082747Z","end":"2026-07-13T20:17:47.314041Z","steps":["trace[1498583247] 'process raft request'  (duration: 231.096745ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:17:48.39878Z","caller":"traceutil/trace.go:171","msg":"trace[877377040] transaction","detail":"{read_only:false; response_revision:8318; number_of_response:1; }","duration":"205.238673ms","start":"2026-07-13T20:17:48.193513Z","end":"2026-07-13T20:17:48.398752Z","steps":["trace[877377040] 'process raft request'  (duration: 205.059288ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:17:48.603556Z","caller":"traceutil/trace.go:171","msg":"trace[703280987] transaction","detail":"{read_only:false; response_revision:8319; number_of_response:1; }","duration":"391.539835ms","start":"2026-07-13T20:17:48.211929Z","end":"2026-07-13T20:17:48.603469Z","steps":["trace[703280987] 'process raft request'  (duration: 320.305739ms)","trace[703280987] 'compare'  (duration: 71.021501ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:17:48.603646Z","caller":"traceutil/trace.go:171","msg":"trace[1522288947] linearizableReadLoop","detail":"{readStateIndex:8608; appliedIndex:8605; }","duration":"354.483431ms","start":"2026-07-13T20:17:48.249124Z","end":"2026-07-13T20:17:48.603608Z","steps":["trace[1522288947] 'read index received'  (duration: 149.509735ms)","trace[1522288947] 'applied index is now lower than readState.Index'  (duration: 204.971466ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:17:48.603701Z","caller":"traceutil/trace.go:171","msg":"trace[1166907034] transaction","detail":"{read_only:false; response_revision:8320; number_of_response:1; }","duration":"389.056594ms","start":"2026-07-13T20:17:48.214626Z","end":"2026-07-13T20:17:48.603682Z","steps":["trace[1166907034] 'process raft request'  (duration: 388.798928ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:17:48.603868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.742607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-07-13T20:17:48.603876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:17:48.214581Z","time spent":"389.240648ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:8309 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-07-13T20:17:48.603769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:17:48.211897Z","time spent":"391.76242ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8308 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-07-13T20:17:48.603915Z","caller":"traceutil/trace.go:171","msg":"trace[1942397409] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:8320; }","duration":"354.821529ms","start":"2026-07-13T20:17:48.24908Z","end":"2026-07-13T20:17:48.603902Z","steps":["trace[1942397409] 'agreement among raft nodes before linearized reading'  (duration: 354.738857ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:17:48.60395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:17:48.249062Z","time spent":"354.87921ms","remote":"127.0.0.1:60060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true "}
{"level":"warn","ts":"2026-07-13T20:17:48.604009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.387136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"}
{"level":"info","ts":"2026-07-13T20:17:48.604058Z","caller":"traceutil/trace.go:171","msg":"trace[803614364] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8320; }","duration":"189.51892ms","start":"2026-07-13T20:17:48.414527Z","end":"2026-07-13T20:17:48.604046Z","steps":["trace[803614364] 'agreement among raft nodes before linearized reading'  (duration: 189.284754ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:17:48.816741Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6152}
{"level":"info","ts":"2026-07-13T20:17:49.088109Z","caller":"traceutil/trace.go:171","msg":"trace[384039498] transaction","detail":"{read_only:false; response_revision:8324; number_of_response:1; }","duration":"174.669137ms","start":"2026-07-13T20:17:48.913398Z","end":"2026-07-13T20:17:49.088067Z","steps":["trace[384039498] 'process raft request'  (duration: 85.172545ms)","trace[384039498] 'compare'  (duration: 29.946181ms)","trace[384039498] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; req_size:541; } (duration: 59.421638ms)"],"step_count":3}
{"level":"info","ts":"2026-07-13T20:17:49.443687Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6152,"took":"625.126509ms","hash":659288197,"current-db-size-bytes":58331136,"current-db-size":"58 MB","current-db-size-in-use-bytes":23547904,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-07-13T20:17:49.445336Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":659288197,"revision":6152,"compact-revision":3023}
{"level":"info","ts":"2026-07-13T20:18:17.046165Z","caller":"traceutil/trace.go:171","msg":"trace[311667088] transaction","detail":"{read_only:false; response_revision:8524; number_of_response:1; }","duration":"342.578436ms","start":"2026-07-13T20:18:16.703561Z","end":"2026-07-13T20:18:17.046139Z","steps":["trace[311667088] 'process raft request'  (duration: 342.428522ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:18:17.046377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:18:16.703536Z","time spent":"342.712829ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8515 > 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-07-13T20:18:17.048775Z","caller":"traceutil/trace.go:171","msg":"trace[202768404] transaction","detail":"{read_only:false; response_revision:8525; number_of_response:1; }","duration":"342.822972ms","start":"2026-07-13T20:18:16.705926Z","end":"2026-07-13T20:18:17.048749Z","steps":["trace[202768404] 'process raft request'  (duration: 342.659108ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:18:17.048935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:18:16.705913Z","time spent":"342.934394ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:8516 > 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":"info","ts":"2026-07-13T20:18:17.049067Z","caller":"traceutil/trace.go:171","msg":"trace[1553818101] transaction","detail":"{read_only:false; response_revision:8526; number_of_response:1; }","duration":"169.097459ms","start":"2026-07-13T20:18:16.87996Z","end":"2026-07-13T20:18:17.049057Z","steps":["trace[1553818101] 'process raft request'  (duration: 168.747761ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:18:17.052231Z","caller":"traceutil/trace.go:171","msg":"trace[333515699] linearizableReadLoop","detail":"{readStateIndex:8821; appliedIndex:8820; }","duration":"302.445408ms","start":"2026-07-13T20:18:16.749744Z","end":"2026-07-13T20:18:17.05219Z","steps":["trace[333515699] 'read index received'  (duration: 296.793691ms)","trace[333515699] 'applied index is now lower than readState.Index'  (duration: 5.650457ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-13T20:18:17.052303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.542761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-13T20:18:17.052392Z","caller":"traceutil/trace.go:171","msg":"trace[1985805652] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:8526; }","duration":"302.663734ms","start":"2026-07-13T20:18:16.749711Z","end":"2026-07-13T20:18:17.052375Z","steps":["trace[1985805652] 'agreement among raft nodes before linearized reading'  (duration: 302.537541ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:18:17.052455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:18:16.7497Z","time spent":"302.745306ms","remote":"127.0.0.1:37972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "}
{"level":"info","ts":"2026-07-13T20:18:20.695525Z","caller":"traceutil/trace.go:171","msg":"trace[239052346] transaction","detail":"{read_only:false; response_revision:8546; number_of_response:1; }","duration":"177.052813ms","start":"2026-07-13T20:18:20.518432Z","end":"2026-07-13T20:18:20.695485Z","steps":["trace[239052346] 'process raft request'  (duration: 176.830938ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:18:45.642033Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000237b.wal"}
{"level":"info","ts":"2026-07-13T20:20:25.631065Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"331455d6226d3423","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-13T20:20:25.637727Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-07-13T20:20:25.637849Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-07-13T20:22:48.825182Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8321}
{"level":"info","ts":"2026-07-13T20:22:48.919085Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8321,"took":"91.412098ms","hash":1053862042,"current-db-size-bytes":58331136,"current-db-size":"58 MB","current-db-size-in-use-bytes":24113152,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-07-13T20:22:48.919167Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1053862042,"revision":8321,"compact-revision":6152}
{"level":"info","ts":"2026-07-13T20:27:48.834138Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10542}
{"level":"info","ts":"2026-07-13T20:27:48.911113Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10542,"took":"74.253928ms","hash":3468214839,"current-db-size-bytes":58331136,"current-db-size":"58 MB","current-db-size-in-use-bytes":26423296,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-07-13T20:27:48.911175Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3468214839,"revision":10542,"compact-revision":8321}
{"level":"info","ts":"2026-07-13T20:32:48.840852Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12804}
{"level":"info","ts":"2026-07-13T20:32:48.927449Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12804,"took":"83.821326ms","hash":2135877121,"current-db-size-bytes":58331136,"current-db-size":"58 MB","current-db-size-in-use-bytes":28778496,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-07-13T20:32:48.927563Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2135877121,"revision":12804,"compact-revision":10542}
{"level":"info","ts":"2026-07-13T20:33:56.840965Z","caller":"traceutil/trace.go:171","msg":"trace[1476536613] transaction","detail":"{read_only:false; response_revision:15629; number_of_response:1; }","duration":"198.73928ms","start":"2026-07-13T20:33:56.642196Z","end":"2026-07-13T20:33:56.840935Z","steps":["trace[1476536613] 'process raft request'  (duration: 113.262933ms)","trace[1476536613] 'compare'  (duration: 85.299553ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:33:56.8412Z","caller":"traceutil/trace.go:171","msg":"trace[843739463] transaction","detail":"{read_only:false; response_revision:15633; number_of_response:1; }","duration":"116.531631ms","start":"2026-07-13T20:33:56.724654Z","end":"2026-07-13T20:33:56.841186Z","steps":["trace[843739463] 'process raft request'  (duration: 116.49453ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:33:56.841234Z","caller":"traceutil/trace.go:171","msg":"trace[1830789103] transaction","detail":"{read_only:false; response_revision:15630; number_of_response:1; }","duration":"194.729433ms","start":"2026-07-13T20:33:56.646433Z","end":"2026-07-13T20:33:56.841163Z","steps":["trace[1830789103] 'process raft request'  (duration: 194.464066ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:33:56.841294Z","caller":"traceutil/trace.go:171","msg":"trace[1380714137] transaction","detail":"{read_only:false; response_revision:15632; number_of_response:1; }","duration":"119.440203ms","start":"2026-07-13T20:33:56.721808Z","end":"2026-07-13T20:33:56.841248Z","steps":["trace[1380714137] 'process raft request'  (duration: 119.30642ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:33:56.841542Z","caller":"traceutil/trace.go:171","msg":"trace[1343177088] transaction","detail":"{read_only:false; response_revision:15631; number_of_response:1; }","duration":"119.434812ms","start":"2026-07-13T20:33:56.721737Z","end":"2026-07-13T20:33:56.841172Z","steps":["trace[1343177088] 'process raft request'  (duration: 119.325689ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:33:56.87431Z","caller":"traceutil/trace.go:171","msg":"trace[1683271922] transaction","detail":"{read_only:false; response_revision:15634; number_of_response:1; }","duration":"104.887149ms","start":"2026-07-13T20:33:56.769395Z","end":"2026-07-13T20:33:56.874282Z","steps":["trace[1683271922] 'process raft request'  (duration: 104.769446ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:33:57.184906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.355132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-g8sjv\" ","response":"range_response_count:1 size:6527"}
{"level":"info","ts":"2026-07-13T20:33:57.185011Z","caller":"traceutil/trace.go:171","msg":"trace[1933059875] range","detail":"{range_begin:/registry/pods/openstack/keepalived-g8sjv; range_end:; response_count:1; response_revision:15634; }","duration":"168.521076ms","start":"2026-07-13T20:33:57.016455Z","end":"2026-07-13T20:33:57.184976Z","steps":["trace[1933059875] 'range keys from in-memory index tree'  (duration: 168.075015ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:33:57.185056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.249865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-ns54q\" ","response":"range_response_count:1 size:20639"}
{"level":"info","ts":"2026-07-13T20:33:57.185153Z","caller":"traceutil/trace.go:171","msg":"trace[759063574] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-ns54q; range_end:; response_count:1; response_revision:15634; }","duration":"102.499611ms","start":"2026-07-13T20:33:57.082633Z","end":"2026-07-13T20:33:57.185133Z","steps":["trace[759063574] 'range keys from in-memory index tree'  (duration: 101.914856ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:37:48.84812Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14944}
{"level":"info","ts":"2026-07-13T20:37:48.940658Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14944,"took":"88.344245ms","hash":601969632,"current-db-size-bytes":58331136,"current-db-size":"58 MB","current-db-size-in-use-bytes":30363648,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-07-13T20:37:48.940733Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":601969632,"revision":14944,"compact-revision":12804}
{"level":"info","ts":"2026-07-13T20:39:59.527694Z","caller":"traceutil/trace.go:171","msg":"trace[82024585] transaction","detail":"{read_only:false; response_revision:18271; number_of_response:1; }","duration":"125.39501ms","start":"2026-07-13T20:39:59.402277Z","end":"2026-07-13T20:39:59.527672Z","steps":["trace[82024585] 'process raft request'  (duration: 59.068192ms)","trace[82024585] 'compare'  (duration: 66.164654ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-13T20:40:07.455707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.90829ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757021736260239378 > lease_revoke:<id:34239f5d13367ed1>","response":"size:28"}
{"level":"info","ts":"2026-07-13T20:40:07.455878Z","caller":"traceutil/trace.go:171","msg":"trace[1788717402] linearizableReadLoop","detail":"{readStateIndex:18951; appliedIndex:18950; }","duration":"272.159169ms","start":"2026-07-13T20:40:07.183693Z","end":"2026-07-13T20:40:07.455852Z","steps":["trace[1788717402] 'read index received'  (duration: 41.075155ms)","trace[1788717402] 'applied index is now lower than readState.Index'  (duration: 231.082194ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-13T20:40:07.456081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.73472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-13T20:40:07.456125Z","caller":"traceutil/trace.go:171","msg":"trace[633667804] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:18331; }","duration":"229.839093ms","start":"2026-07-13T20:40:07.22627Z","end":"2026-07-13T20:40:07.456109Z","steps":["trace[633667804] 'agreement among raft nodes before linearized reading'  (duration: 229.71807ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:40:07.456107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.387454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-07-13T20:40:07.456133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.812868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-13T20:40:07.456187Z","caller":"traceutil/trace.go:171","msg":"trace[1893948647] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:18331; }","duration":"272.529358ms","start":"2026-07-13T20:40:07.183636Z","end":"2026-07-13T20:40:07.456165Z","steps":["trace[1893948647] 'agreement among raft nodes before linearized reading'  (duration: 272.309462ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:40:07.45626Z","caller":"traceutil/trace.go:171","msg":"trace[2139891104] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18331; }","duration":"129.996463ms","start":"2026-07-13T20:40:07.326228Z","end":"2026-07-13T20:40:07.456225Z","steps":["trace[2139891104] 'agreement among raft nodes before linearized reading'  (duration: 129.773468ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:41:49.891746Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"331455d6226d3423","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-13T20:41:49.90207Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-07-13T20:41:49.902169Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-07-13T20:42:48.854722Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17390}
{"level":"info","ts":"2026-07-13T20:42:48.953629Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17390,"took":"95.390702ms","hash":630200815,"current-db-size-bytes":58331136,"current-db-size":"58 MB","current-db-size-in-use-bytes":33890304,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-07-13T20:42:48.953691Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":630200815,"revision":17390,"compact-revision":14944}
{"level":"info","ts":"2026-07-13T20:46:22.70936Z","caller":"traceutil/trace.go:171","msg":"trace[1469117398] linearizableReadLoop","detail":"{readStateIndex:21881; appliedIndex:21880; }","duration":"133.969348ms","start":"2026-07-13T20:46:22.575367Z","end":"2026-07-13T20:46:22.709336Z","steps":["trace[1469117398] 'read index received'  (duration: 133.667911ms)","trace[1469117398] 'applied index is now lower than readState.Index'  (duration: 300.207µs)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:46:22.709398Z","caller":"traceutil/trace.go:171","msg":"trace[700432851] transaction","detail":"{read_only:false; response_revision:21167; number_of_response:1; }","duration":"139.708117ms","start":"2026-07-13T20:46:22.569665Z","end":"2026-07-13T20:46:22.709373Z","steps":["trace[700432851] 'process raft request'  (duration: 139.491102ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:46:22.709614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.059799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-07-13T20:46:22.70965Z","caller":"traceutil/trace.go:171","msg":"trace[1979293902] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21167; }","duration":"103.149251ms","start":"2026-07-13T20:46:22.606491Z","end":"2026-07-13T20:46:22.709641Z","steps":["trace[1979293902] 'agreement among raft nodes before linearized reading'  (duration: 102.987078ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:46:22.709643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.253995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-07-13T20:46:22.709706Z","caller":"traceutil/trace.go:171","msg":"trace[2089024867] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21167; }","duration":"134.354448ms","start":"2026-07-13T20:46:22.575334Z","end":"2026-07-13T20:46:22.709688Z","steps":["trace[2089024867] 'agreement among raft nodes before linearized reading'  (duration: 134.138522ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:46:22.93653Z","caller":"traceutil/trace.go:171","msg":"trace[1705325742] transaction","detail":"{read_only:false; response_revision:21168; number_of_response:1; }","duration":"222.022253ms","start":"2026-07-13T20:46:22.714479Z","end":"2026-07-13T20:46:22.936502Z","steps":["trace[1705325742] 'process raft request'  (duration: 166.938187ms)","trace[1705325742] 'compare'  (duration: 54.582514ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:46:22.941169Z","caller":"traceutil/trace.go:171","msg":"trace[1097721233] transaction","detail":"{read_only:false; response_revision:21169; number_of_response:1; }","duration":"226.537663ms","start":"2026-07-13T20:46:22.714592Z","end":"2026-07-13T20:46:22.941129Z","steps":["trace[1097721233] 'process raft request'  (duration: 226.320207ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:47:48.861753Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19694}
{"level":"info","ts":"2026-07-13T20:47:48.966894Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19694,"took":"102.085984ms","hash":1306516425,"current-db-size-bytes":58331136,"current-db-size":"58 MB","current-db-size-in-use-bytes":29954048,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-07-13T20:47:48.966968Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1306516425,"revision":19694,"compact-revision":17390}
{"level":"warn","ts":"2026-07-13T20:50:23.90049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.488086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-13T20:50:23.900602Z","caller":"traceutil/trace.go:171","msg":"trace[473986786] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:23677; }","duration":"220.67994ms","start":"2026-07-13T20:50:23.679897Z","end":"2026-07-13T20:50:23.900577Z","steps":["trace[473986786] 'count revisions from in-memory index tree'  (duration: 220.347053ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:52:48.869376Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21935}
{"level":"info","ts":"2026-07-13T20:52:48.987973Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21935,"took":"114.22708ms","hash":717171371,"current-db-size-bytes":58331136,"current-db-size":"58 MB","current-db-size-in-use-bytes":44871680,"current-db-size-in-use":"45 MB"}
{"level":"info","ts":"2026-07-13T20:52:48.988034Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":717171371,"revision":21935,"compact-revision":19694}
{"level":"info","ts":"2026-07-13T20:53:20.033635Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-000000000000665a.wal"}
{"level":"info","ts":"2026-07-13T20:53:57.358922Z","caller":"traceutil/trace.go:171","msg":"trace[180638934] linearizableReadLoop","detail":"{readStateIndex:26634; appliedIndex:26633; }","duration":"184.74194ms","start":"2026-07-13T20:53:57.174146Z","end":"2026-07-13T20:53:57.358888Z","steps":["trace[180638934] 'read index received'  (duration: 184.518795ms)","trace[180638934] 'applied index is now lower than readState.Index'  (duration: 221.735µs)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:53:57.359035Z","caller":"traceutil/trace.go:171","msg":"trace[267530473] transaction","detail":"{read_only:false; response_revision:25791; number_of_response:1; }","duration":"249.521401ms","start":"2026-07-13T20:53:57.109458Z","end":"2026-07-13T20:53:57.35898Z","steps":["trace[267530473] 'process raft request'  (duration: 249.194583ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:53:57.359176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.992236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-13T20:53:57.359239Z","caller":"traceutil/trace.go:171","msg":"trace[8233659] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:25791; }","duration":"185.109969ms","start":"2026-07-13T20:53:57.174111Z","end":"2026-07-13T20:53:57.359221Z","steps":["trace[8233659] 'agreement among raft nodes before linearized reading'  (duration: 184.954435ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:53:57.841702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.203127ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757021736260259699 > lease_revoke:<id:34239f5d1336cd2b>","response":"size:28"}
{"level":"info","ts":"2026-07-13T20:53:57.842048Z","caller":"traceutil/trace.go:171","msg":"trace[111981577] linearizableReadLoop","detail":"{readStateIndex:26635; appliedIndex:26634; }","duration":"482.977931ms","start":"2026-07-13T20:53:57.359044Z","end":"2026-07-13T20:53:57.842022Z","steps":["trace[111981577] 'read index received'  (duration: 119.539909ms)","trace[111981577] 'applied index is now lower than readState.Index'  (duration: 363.436482ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:53:57.842439Z","caller":"traceutil/trace.go:171","msg":"trace[1337077548] transaction","detail":"{read_only:false; response_revision:25792; number_of_response:1; }","duration":"387.370035ms","start":"2026-07-13T20:53:57.455036Z","end":"2026-07-13T20:53:57.842407Z","steps":["trace[1337077548] 'process raft request'  (duration: 386.81631ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:53:57.842607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:53:57.454985Z","time spent":"387.530728ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25774 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-07-13T20:53:57.889093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.626842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-07-13T20:53:57.889157Z","caller":"traceutil/trace.go:171","msg":"trace[235349251] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25792; }","duration":"543.729785ms","start":"2026-07-13T20:53:57.345406Z","end":"2026-07-13T20:53:57.889136Z","steps":["trace[235349251] 'agreement among raft nodes before linearized reading'  (duration: 496.926481ms)","trace[235349251] 'range keys from in-memory index tree'  (duration: 46.60147ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-13T20:53:57.889201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:53:57.345384Z","time spent":"543.808037ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-07-13T20:53:57.889697Z","caller":"traceutil/trace.go:171","msg":"trace[415176968] transaction","detail":"{read_only:false; response_revision:25793; number_of_response:1; }","duration":"224.063503ms","start":"2026-07-13T20:53:57.665612Z","end":"2026-07-13T20:53:57.889675Z","steps":["trace[415176968] 'process raft request'  (duration: 178.467537ms)","trace[415176968] 'compare'  (duration: 45.417572ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:53:57.915807Z","caller":"traceutil/trace.go:171","msg":"trace[1043577866] transaction","detail":"{read_only:false; response_revision:25794; number_of_response:1; }","duration":"193.670136ms","start":"2026-07-13T20:53:57.722085Z","end":"2026-07-13T20:53:57.915755Z","steps":["trace[1043577866] 'process raft request'  (duration: 193.296187ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:53:57.916096Z","caller":"traceutil/trace.go:171","msg":"trace[152554189] transaction","detail":"{read_only:false; response_revision:25796; number_of_response:1; }","duration":"121.942018ms","start":"2026-07-13T20:53:57.794139Z","end":"2026-07-13T20:53:57.916081Z","steps":["trace[152554189] 'process raft request'  (duration: 121.754973ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:53:57.916246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.33893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-07-13T20:53:57.916322Z","caller":"traceutil/trace.go:171","msg":"trace[1837370326] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25796; }","duration":"405.489593ms","start":"2026-07-13T20:53:57.510816Z","end":"2026-07-13T20:53:57.916305Z","steps":["trace[1837370326] 'agreement among raft nodes before linearized reading'  (duration: 405.263468ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:53:57.916371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:53:57.510784Z","time spent":"405.573566ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-07-13T20:53:57.916506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.672462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-07-13T20:53:57.915985Z","caller":"traceutil/trace.go:171","msg":"trace[1200323012] transaction","detail":"{read_only:false; response_revision:25795; number_of_response:1; }","duration":"190.483899ms","start":"2026-07-13T20:53:57.725449Z","end":"2026-07-13T20:53:57.915933Z","steps":["trace[1200323012] 'process raft request'  (duration: 190.10709ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:53:57.916632Z","caller":"traceutil/trace.go:171","msg":"trace[903699365] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25796; }","duration":"359.893987ms","start":"2026-07-13T20:53:57.556707Z","end":"2026-07-13T20:53:57.916601Z","steps":["trace[903699365] 'agreement among raft nodes before linearized reading'  (duration: 359.472007ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:53:57.916684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:53:57.556676Z","time spent":"359.997689ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-07-13T20:53:57.917087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.073131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-07-13T20:53:57.919431Z","caller":"traceutil/trace.go:171","msg":"trace[892584177] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25796; }","duration":"355.249135ms","start":"2026-07-13T20:53:57.561938Z","end":"2026-07-13T20:53:57.917187Z","steps":["trace[892584177] 'agreement among raft nodes before linearized reading'  (duration: 354.817445ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:53:57.91963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:53:57.561929Z","time spent":"357.682004ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-07-13T20:54:04.34132Z","caller":"traceutil/trace.go:171","msg":"trace[995714454] transaction","detail":"{read_only:false; response_revision:25852; number_of_response:1; }","duration":"403.405102ms","start":"2026-07-13T20:54:03.937885Z","end":"2026-07-13T20:54:04.34129Z","steps":["trace[995714454] 'process raft request'  (duration: 403.202687ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:04.341523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:03.937857Z","time spent":"403.552346ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25840 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"warn","ts":"2026-07-13T20:54:04.645827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.047553ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757021736260259839 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25839 > 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:18"}
{"level":"info","ts":"2026-07-13T20:54:04.646132Z","caller":"traceutil/trace.go:171","msg":"trace[1842543672] linearizableReadLoop","detail":"{readStateIndex:26699; appliedIndex:26696; }","duration":"692.283397ms","start":"2026-07-13T20:54:03.953824Z","end":"2026-07-13T20:54:04.646107Z","steps":["trace[1842543672] 'read index received'  (duration: 387.313282ms)","trace[1842543672] 'applied index is now lower than readState.Index'  (duration: 304.968285ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:54:04.646146Z","caller":"traceutil/trace.go:171","msg":"trace[1054590937] transaction","detail":"{read_only:false; response_revision:25853; number_of_response:1; }","duration":"706.939592ms","start":"2026-07-13T20:54:03.939173Z","end":"2026-07-13T20:54:04.646113Z","steps":["trace[1054590937] 'process raft request'  (duration: 562.46589ms)","trace[1054590937] 'compare'  (duration: 143.695554ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:54:04.646143Z","caller":"traceutil/trace.go:171","msg":"trace[331538571] transaction","detail":"{read_only:false; response_revision:25854; number_of_response:1; }","duration":"705.864077ms","start":"2026-07-13T20:54:03.940238Z","end":"2026-07-13T20:54:04.646102Z","steps":["trace[331538571] 'process raft request'  (duration: 705.731164ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:04.646206Z","caller":"traceutil/trace.go:171","msg":"trace[1414362659] transaction","detail":"{read_only:false; response_revision:25855; number_of_response:1; }","duration":"442.539632ms","start":"2026-07-13T20:54:04.203599Z","end":"2026-07-13T20:54:04.646139Z","steps":["trace[1414362659] 'process raft request'  (duration: 442.44564ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:04.646311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:03.939148Z","time spent":"707.065836ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25839 > 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-07-13T20:54:04.646338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:03.940232Z","time spent":"705.99559ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25841 > 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-07-13T20:54:04.646367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.052365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-07-13T20:54:04.646402Z","caller":"traceutil/trace.go:171","msg":"trace[652794468] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25855; }","duration":"681.141037ms","start":"2026-07-13T20:54:03.965251Z","end":"2026-07-13T20:54:04.646393Z","steps":["trace[652794468] 'agreement among raft nodes before linearized reading'  (duration: 681.040485ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:04.646422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:03.965226Z","time spent":"681.191159ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-07-13T20:54:04.646403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:04.203569Z","time spent":"442.721226ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25846 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-07-13T20:54:04.646439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"691.403096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-07-13T20:54:04.646448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.573083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-07-13T20:54:04.646496Z","caller":"traceutil/trace.go:171","msg":"trace[263886738] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25855; }","duration":"691.513828ms","start":"2026-07-13T20:54:03.954965Z","end":"2026-07-13T20:54:04.646479Z","steps":["trace[263886738] 'agreement among raft nodes before linearized reading'  (duration: 691.301463ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:04.646511Z","caller":"traceutil/trace.go:171","msg":"trace[857989732] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25855; }","duration":"687.639904ms","start":"2026-07-13T20:54:03.958849Z","end":"2026-07-13T20:54:04.646489Z","steps":["trace[857989732] 'agreement among raft nodes before linearized reading'  (duration: 687.46565ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:04.646539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:03.954949Z","time spent":"691.581129ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-07-13T20:54:04.646555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:03.958843Z","time spent":"687.700306ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-07-13T20:54:04.646556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"692.742549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-07-13T20:54:04.646599Z","caller":"traceutil/trace.go:171","msg":"trace[1213130437] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25855; }","duration":"692.840781ms","start":"2026-07-13T20:54:03.953746Z","end":"2026-07-13T20:54:04.646587Z","steps":["trace[1213130437] 'agreement among raft nodes before linearized reading'  (duration: 692.423191ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:04.64662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:03.953732Z","time spent":"692.884181ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-07-13T20:54:05.145137Z","caller":"traceutil/trace.go:171","msg":"trace[1618650645] transaction","detail":"{read_only:false; response_revision:25856; number_of_response:1; }","duration":"491.075598ms","start":"2026-07-13T20:54:04.654035Z","end":"2026-07-13T20:54:05.14511Z","steps":["trace[1618650645] 'process raft request'  (duration: 490.879053ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:05.145302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:04.654007Z","time spent":"491.206991ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25845 > 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-07-13T20:54:05.169384Z","caller":"traceutil/trace.go:171","msg":"trace[2048719440] transaction","detail":"{read_only:false; response_revision:25857; number_of_response:1; }","duration":"515.196874ms","start":"2026-07-13T20:54:04.65415Z","end":"2026-07-13T20:54:05.169347Z","steps":["trace[2048719440] 'process raft request'  (duration: 514.166979ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:05.169614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:04.654119Z","time spent":"515.368277ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25844 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-07-13T20:54:05.169796Z","caller":"traceutil/trace.go:171","msg":"trace[64069956] transaction","detail":"{read_only:false; response_revision:25858; number_of_response:1; }","duration":"515.574042ms","start":"2026-07-13T20:54:04.654208Z","end":"2026-07-13T20:54:05.169782Z","steps":["trace[64069956] 'process raft request'  (duration: 514.290291ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:05.169861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:04.654175Z","time spent":"515.646294ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25842 > 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-07-13T20:54:05.170002Z","caller":"traceutil/trace.go:171","msg":"trace[438456208] transaction","detail":"{read_only:false; response_revision:25859; number_of_response:1; }","duration":"515.668405ms","start":"2026-07-13T20:54:04.654324Z","end":"2026-07-13T20:54:05.169992Z","steps":["trace[438456208] 'process raft request'  (duration: 514.21932ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:05.170053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:04.654314Z","time spent":"515.709716ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25843 > 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":"info","ts":"2026-07-13T20:54:05.170172Z","caller":"traceutil/trace.go:171","msg":"trace[1118675501] transaction","detail":"{read_only:false; response_revision:25860; number_of_response:1; }","duration":"298.121569ms","start":"2026-07-13T20:54:04.87204Z","end":"2026-07-13T20:54:05.170162Z","steps":["trace[1118675501] 'process raft request'  (duration: 296.549222ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:05.44818Z","caller":"traceutil/trace.go:171","msg":"trace[1252504273] linearizableReadLoop","detail":"{readStateIndex:26707; appliedIndex:26706; }","duration":"122.826308ms","start":"2026-07-13T20:54:05.325298Z","end":"2026-07-13T20:54:05.448124Z","steps":["trace[1252504273] 'read index received'  (duration: 122.698125ms)","trace[1252504273] 'applied index is now lower than readState.Index'  (duration: 126.563µs)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:54:05.448553Z","caller":"traceutil/trace.go:171","msg":"trace[655685573] transaction","detail":"{read_only:false; response_revision:25862; number_of_response:1; }","duration":"168.043005ms","start":"2026-07-13T20:54:05.280496Z","end":"2026-07-13T20:54:05.448539Z","steps":["trace[655685573] 'process raft request'  (duration: 167.44219ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:05.448793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.491295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-13T20:54:05.448841Z","caller":"traceutil/trace.go:171","msg":"trace[401914051] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25862; }","duration":"123.594867ms","start":"2026-07-13T20:54:05.325236Z","end":"2026-07-13T20:54:05.448831Z","steps":["trace[401914051] 'agreement among raft nodes before linearized reading'  (duration: 123.503735ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:05.449627Z","caller":"traceutil/trace.go:171","msg":"trace[1702639173] transaction","detail":"{read_only:false; response_revision:25863; number_of_response:1; }","duration":"115.04015ms","start":"2026-07-13T20:54:05.334566Z","end":"2026-07-13T20:54:05.449606Z","steps":["trace[1702639173] 'process raft request'  (duration: 114.734052ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:05.622145Z","caller":"traceutil/trace.go:171","msg":"trace[204716023] transaction","detail":"{read_only:false; response_revision:25864; number_of_response:1; }","duration":"153.122214ms","start":"2026-07-13T20:54:05.469003Z","end":"2026-07-13T20:54:05.622125Z","steps":["trace[204716023] 'process raft request'  (duration: 135.27501ms)","trace[204716023] 'compare'  (duration: 17.760512ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-13T20:54:05.93229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.687061ms","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:8"}
{"level":"info","ts":"2026-07-13T20:54:05.932376Z","caller":"traceutil/trace.go:171","msg":"trace[1125638975] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25864; }","duration":"154.807784ms","start":"2026-07-13T20:54:05.777551Z","end":"2026-07-13T20:54:05.932358Z","steps":["trace[1125638975] 'count revisions from in-memory index tree'  (duration: 154.60815ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:06.20749Z","caller":"traceutil/trace.go:171","msg":"trace[1122892215] linearizableReadLoop","detail":"{readStateIndex:26711; appliedIndex:26710; }","duration":"244.734315ms","start":"2026-07-13T20:54:05.962724Z","end":"2026-07-13T20:54:06.207458Z","steps":["trace[1122892215] 'read index received'  (duration: 156.090256ms)","trace[1122892215] 'applied index is now lower than readState.Index'  (duration: 88.642539ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-13T20:54:06.20767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.91243ms","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:6"}
{"level":"info","ts":"2026-07-13T20:54:06.207738Z","caller":"traceutil/trace.go:171","msg":"trace[15263026] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:25866; }","duration":"245.007782ms","start":"2026-07-13T20:54:05.962713Z","end":"2026-07-13T20:54:06.207721Z","steps":["trace[15263026] 'agreement among raft nodes before linearized reading'  (duration: 244.875489ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:06.207748Z","caller":"traceutil/trace.go:171","msg":"trace[1921567505] transaction","detail":"{read_only:false; response_revision:25866; number_of_response:1; }","duration":"287.422881ms","start":"2026-07-13T20:54:05.920293Z","end":"2026-07-13T20:54:06.207716Z","steps":["trace[1921567505] 'process raft request'  (duration: 198.505144ms)","trace[1921567505] 'compare'  (duration: 88.523367ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:54:06.290294Z","caller":"traceutil/trace.go:171","msg":"trace[200203462] transaction","detail":"{read_only:false; response_revision:25867; number_of_response:1; }","duration":"205.086183ms","start":"2026-07-13T20:54:06.085174Z","end":"2026-07-13T20:54:06.29026Z","steps":["trace[200203462] 'process raft request'  (duration: 204.911769ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:06.452659Z","caller":"traceutil/trace.go:171","msg":"trace[206676357] linearizableReadLoop","detail":"{readStateIndex:26713; appliedIndex:26712; }","duration":"186.249866ms","start":"2026-07-13T20:54:06.266381Z","end":"2026-07-13T20:54:06.45263Z","steps":["trace[206676357] 'read index received'  (duration: 23.93293ms)","trace[206676357] 'applied index is now lower than readState.Index'  (duration: 162.315346ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:54:06.452773Z","caller":"traceutil/trace.go:171","msg":"trace[1155746640] transaction","detail":"{read_only:false; response_revision:25868; number_of_response:1; }","duration":"263.065759ms","start":"2026-07-13T20:54:06.189664Z","end":"2026-07-13T20:54:06.45273Z","steps":["trace[1155746640] 'process raft request'  (duration: 262.792042ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:06.452973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.557173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-07-13T20:54:06.45305Z","caller":"traceutil/trace.go:171","msg":"trace[1277671103] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:25868; }","duration":"186.694007ms","start":"2026-07-13T20:54:06.266337Z","end":"2026-07-13T20:54:06.453031Z","steps":["trace[1277671103] 'agreement among raft nodes before linearized reading'  (duration: 186.466081ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:06.46594Z","caller":"traceutil/trace.go:171","msg":"trace[1155770290] transaction","detail":"{read_only:false; response_revision:25869; number_of_response:1; }","duration":"118.130835ms","start":"2026-07-13T20:54:06.34778Z","end":"2026-07-13T20:54:06.465911Z","steps":["trace[1155770290] 'process raft request'  (duration: 117.013457ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:06.830096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.175407ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757021736260259869 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/magnum-api-7cd95b8448-6clxn.18c1f4c32c001eb4\" mod_revision:25870 > success:<request_put:<key:\"/registry/events/openstack/magnum-api-7cd95b8448-6clxn.18c1f4c32c001eb4\" value_size:725 lease:3757021736260258824 >> failure:<request_range:<key:\"/registry/events/openstack/magnum-api-7cd95b8448-6clxn.18c1f4c32c001eb4\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-13T20:54:06.830207Z","caller":"traceutil/trace.go:171","msg":"trace[1045392676] transaction","detail":"{read_only:false; response_revision:25871; number_of_response:1; }","duration":"276.106416ms","start":"2026-07-13T20:54:06.554082Z","end":"2026-07-13T20:54:06.830189Z","steps":["trace[1045392676] 'process raft request'  (duration: 131.752915ms)","trace[1045392676] 'compare'  (duration: 143.87327ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:54:06.857187Z","caller":"traceutil/trace.go:171","msg":"trace[1397977278] transaction","detail":"{read_only:false; response_revision:25873; number_of_response:1; }","duration":"204.233443ms","start":"2026-07-13T20:54:06.652932Z","end":"2026-07-13T20:54:06.857165Z","steps":["trace[1397977278] 'process raft request'  (duration: 204.172341ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:06.857358Z","caller":"traceutil/trace.go:171","msg":"trace[1074866900] linearizableReadLoop","detail":"{readStateIndex:26719; appliedIndex:26715; }","duration":"199.301564ms","start":"2026-07-13T20:54:06.658037Z","end":"2026-07-13T20:54:06.857339Z","steps":["trace[1074866900] 'read index received'  (duration: 28.02038ms)","trace[1074866900] 'applied index is now lower than readState.Index'  (duration: 171.279594ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:54:06.857455Z","caller":"traceutil/trace.go:171","msg":"trace[1972117804] transaction","detail":"{read_only:false; response_revision:25874; number_of_response:1; }","duration":"202.851439ms","start":"2026-07-13T20:54:06.654597Z","end":"2026-07-13T20:54:06.857449Z","steps":["trace[1972117804] 'process raft request'  (duration: 202.539162ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:06.857511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.450577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-13T20:54:06.857557Z","caller":"traceutil/trace.go:171","msg":"trace[1327275305] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:25874; }","duration":"199.55388ms","start":"2026-07-13T20:54:06.657989Z","end":"2026-07-13T20:54:06.857543Z","steps":["trace[1327275305] 'agreement among raft nodes before linearized reading'  (duration: 199.440047ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:06.857973Z","caller":"traceutil/trace.go:171","msg":"trace[1129796031] transaction","detail":"{read_only:false; response_revision:25872; number_of_response:1; }","duration":"205.558575ms","start":"2026-07-13T20:54:06.651637Z","end":"2026-07-13T20:54:06.857196Z","steps":["trace[1129796031] 'process raft request'  (duration: 205.344969ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:07.486913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.194886ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757021736260259881 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25860 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-13T20:54:07.487196Z","caller":"traceutil/trace.go:171","msg":"trace[1366383630] transaction","detail":"{read_only:false; response_revision:25878; number_of_response:1; }","duration":"235.324217ms","start":"2026-07-13T20:54:07.251843Z","end":"2026-07-13T20:54:07.487167Z","steps":["trace[1366383630] 'process raft request'  (duration: 235.197134ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:07.487423Z","caller":"traceutil/trace.go:171","msg":"trace[1323187189] transaction","detail":"{read_only:false; response_revision:25879; number_of_response:1; }","duration":"235.235374ms","start":"2026-07-13T20:54:07.252148Z","end":"2026-07-13T20:54:07.487383Z","steps":["trace[1323187189] 'process raft request'  (duration: 234.934186ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:07.48742Z","caller":"traceutil/trace.go:171","msg":"trace[1785260829] transaction","detail":"{read_only:false; response_revision:25880; number_of_response:1; }","duration":"234.481436ms","start":"2026-07-13T20:54:07.252882Z","end":"2026-07-13T20:54:07.487364Z","steps":["trace[1785260829] 'process raft request'  (duration: 234.234459ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:07.487509Z","caller":"traceutil/trace.go:171","msg":"trace[610381011] transaction","detail":"{read_only:false; response_revision:25877; number_of_response:1; }","duration":"310.50249ms","start":"2026-07-13T20:54:07.176991Z","end":"2026-07-13T20:54:07.487494Z","steps":["trace[610381011] 'process raft request'  (duration: 191.617976ms)","trace[610381011] 'compare'  (duration: 118.033932ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:54:07.487745Z","caller":"traceutil/trace.go:171","msg":"trace[1989650098] linearizableReadLoop","detail":"{readStateIndex:26722; appliedIndex:26720; }","duration":"310.435668ms","start":"2026-07-13T20:54:07.17728Z","end":"2026-07-13T20:54:07.487716Z","steps":["trace[1989650098] 'read index received'  (duration: 98.496048ms)","trace[1989650098] 'applied index is now lower than readState.Index'  (duration: 211.93619ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-13T20:54:07.48768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:07.176975Z","time spent":"310.578651ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25860 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-07-13T20:54:07.493151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.585459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-13T20:54:07.493203Z","caller":"traceutil/trace.go:171","msg":"trace[144771749] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:25880; }","duration":"220.714243ms","start":"2026-07-13T20:54:07.272477Z","end":"2026-07-13T20:54:07.493192Z","steps":["trace[144771749] 'agreement among raft nodes before linearized reading'  (duration: 220.59642ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:07.493564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.28944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-07-13T20:54:07.493582Z","caller":"traceutil/trace.go:171","msg":"trace[1237089229] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25880; }","duration":"316.361632ms","start":"2026-07-13T20:54:07.177216Z","end":"2026-07-13T20:54:07.493577Z","steps":["trace[1237089229] 'agreement among raft nodes before linearized reading'  (duration: 310.624633ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:07.493598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:07.177185Z","time spent":"316.406062ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-07-13T20:54:07.493784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.286146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-13T20:54:07.493799Z","caller":"traceutil/trace.go:171","msg":"trace[212393147] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25880; }","duration":"169.353967ms","start":"2026-07-13T20:54:07.32444Z","end":"2026-07-13T20:54:07.493794Z","steps":["trace[212393147] 'agreement among raft nodes before linearized reading'  (duration: 169.324946ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:13.426581Z","caller":"traceutil/trace.go:171","msg":"trace[1498796935] transaction","detail":"{read_only:false; response_revision:25932; number_of_response:1; }","duration":"126.5606ms","start":"2026-07-13T20:54:13.299989Z","end":"2026-07-13T20:54:13.426549Z","steps":["trace[1498796935] 'process raft request'  (duration: 126.334525ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:13.719824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.251308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-07-13T20:54:13.719914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.922871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-07-13T20:54:13.719943Z","caller":"traceutil/trace.go:171","msg":"trace[1483424725] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25932; }","duration":"177.436342ms","start":"2026-07-13T20:54:13.542478Z","end":"2026-07-13T20:54:13.719915Z","steps":["trace[1483424725] 'range keys from in-memory index tree'  (duration: 177.017473ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:13.720002Z","caller":"traceutil/trace.go:171","msg":"trace[2075583665] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25932; }","duration":"203.060194ms","start":"2026-07-13T20:54:13.516921Z","end":"2026-07-13T20:54:13.719981Z","steps":["trace[2075583665] 'range keys from in-memory index tree'  (duration: 202.777217ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:13.720077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.081418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"}
{"level":"warn","ts":"2026-07-13T20:54:13.71998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.101295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"warn","ts":"2026-07-13T20:54:13.72008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.971781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-07-13T20:54:13.720136Z","caller":"traceutil/trace.go:171","msg":"trace[1591575690] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25932; }","duration":"203.3086ms","start":"2026-07-13T20:54:13.516813Z","end":"2026-07-13T20:54:13.720122Z","steps":["trace[1591575690] 'range keys from in-memory index tree'  (duration: 202.92319ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:13.720134Z","caller":"traceutil/trace.go:171","msg":"trace[1543587202] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:25932; }","duration":"272.128179ms","start":"2026-07-13T20:54:13.447986Z","end":"2026-07-13T20:54:13.720114Z","steps":["trace[1543587202] 'range keys from in-memory index tree'  (duration: 271.78336ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:13.720176Z","caller":"traceutil/trace.go:171","msg":"trace[385223418] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25932; }","duration":"203.121965ms","start":"2026-07-13T20:54:13.517029Z","end":"2026-07-13T20:54:13.720151Z","steps":["trace[385223418] 'range keys from in-memory index tree'  (duration: 202.768757ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:13.722128Z","caller":"traceutil/trace.go:171","msg":"trace[2103485413] transaction","detail":"{read_only:false; response_revision:25933; number_of_response:1; }","duration":"175.245419ms","start":"2026-07-13T20:54:13.54684Z","end":"2026-07-13T20:54:13.722086Z","steps":["trace[2103485413] 'process raft request'  (duration: 110.461318ms)","trace[2103485413] 'compare'  (duration: 62.628638ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:54:13.877535Z","caller":"traceutil/trace.go:171","msg":"trace[214849733] transaction","detail":"{read_only:false; response_revision:25935; number_of_response:1; }","duration":"152.184501ms","start":"2026-07-13T20:54:13.725321Z","end":"2026-07-13T20:54:13.877505Z","steps":["trace[214849733] 'process raft request'  (duration: 139.988055ms)","trace[214849733] 'compare'  (duration: 11.803946ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-13T20:54:13.87766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.732228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-13T20:54:13.877552Z","caller":"traceutil/trace.go:171","msg":"trace[1742165515] linearizableReadLoop","detail":"{readStateIndex:26785; appliedIndex:26780; }","duration":"146.629956ms","start":"2026-07-13T20:54:13.730899Z","end":"2026-07-13T20:54:13.877529Z","steps":["trace[1742165515] 'read index received'  (duration: 71.664208ms)","trace[1742165515] 'applied index is now lower than readState.Index'  (duration: 74.965008ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:54:13.877711Z","caller":"traceutil/trace.go:171","msg":"trace[959373221] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:25938; }","duration":"146.823231ms","start":"2026-07-13T20:54:13.730873Z","end":"2026-07-13T20:54:13.877696Z","steps":["trace[959373221] 'agreement among raft nodes before linearized reading'  (duration: 146.728299ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:13.87816Z","caller":"traceutil/trace.go:171","msg":"trace[741498598] transaction","detail":"{read_only:false; response_revision:25936; number_of_response:1; }","duration":"152.335205ms","start":"2026-07-13T20:54:13.725812Z","end":"2026-07-13T20:54:13.878147Z","steps":["trace[741498598] 'process raft request'  (duration: 151.543346ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:13.878311Z","caller":"traceutil/trace.go:171","msg":"trace[1287432733] transaction","detail":"{read_only:false; response_revision:25937; number_of_response:1; }","duration":"152.083877ms","start":"2026-07-13T20:54:13.726217Z","end":"2026-07-13T20:54:13.878301Z","steps":["trace[1287432733] 'process raft request'  (duration: 151.230887ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:13.878393Z","caller":"traceutil/trace.go:171","msg":"trace[968483565] transaction","detail":"{read_only:false; response_revision:25938; number_of_response:1; }","duration":"152.103388ms","start":"2026-07-13T20:54:13.726274Z","end":"2026-07-13T20:54:13.878377Z","steps":["trace[968483565] 'process raft request'  (duration: 151.214787ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:14.308459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.318497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-07-13T20:54:14.308545Z","caller":"traceutil/trace.go:171","msg":"trace[1617105079] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:25940; }","duration":"160.472941ms","start":"2026-07-13T20:54:14.148052Z","end":"2026-07-13T20:54:14.308525Z","steps":["trace[1617105079] 'count revisions from in-memory index tree'  (duration: 160.189744ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:15.001057Z","caller":"traceutil/trace.go:171","msg":"trace[1283091522] transaction","detail":"{read_only:false; response_revision:25943; number_of_response:1; }","duration":"114.572719ms","start":"2026-07-13T20:54:14.886454Z","end":"2026-07-13T20:54:15.001027Z","steps":["trace[1283091522] 'process raft request'  (duration: 114.370134ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:15.141792Z","caller":"traceutil/trace.go:171","msg":"trace[1823933564] transaction","detail":"{read_only:false; response_revision:25945; number_of_response:1; }","duration":"253.894297ms","start":"2026-07-13T20:54:14.887871Z","end":"2026-07-13T20:54:15.141765Z","steps":["trace[1823933564] 'process raft request'  (duration: 253.840076ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:15.141909Z","caller":"traceutil/trace.go:171","msg":"trace[1296641873] transaction","detail":"{read_only:false; response_revision:25944; number_of_response:1; }","duration":"255.106866ms","start":"2026-07-13T20:54:14.886759Z","end":"2026-07-13T20:54:15.141866Z","steps":["trace[1296641873] 'process raft request'  (duration: 254.758788ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:23.280893Z","caller":"traceutil/trace.go:171","msg":"trace[1773696946] transaction","detail":"{read_only:false; response_revision:26018; number_of_response:1; }","duration":"246.789244ms","start":"2026-07-13T20:54:23.034074Z","end":"2026-07-13T20:54:23.280863Z","steps":["trace[1773696946] 'process raft request'  (duration: 246.486277ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:23.900427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.732221ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757021736260260200 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:26001 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-13T20:54:23.900682Z","caller":"traceutil/trace.go:171","msg":"trace[694241057] linearizableReadLoop","detail":"{readStateIndex:26869; appliedIndex:26866; }","duration":"629.635819ms","start":"2026-07-13T20:54:23.27103Z","end":"2026-07-13T20:54:23.900666Z","steps":["trace[694241057] 'read index received'  (duration: 9.50992ms)","trace[694241057] 'applied index is now lower than readState.Index'  (duration: 620.124998ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:54:23.900761Z","caller":"traceutil/trace.go:171","msg":"trace[1923860663] transaction","detail":"{read_only:false; response_revision:26020; number_of_response:1; }","duration":"726.839435ms","start":"2026-07-13T20:54:23.17391Z","end":"2026-07-13T20:54:23.900749Z","steps":["trace[1923860663] 'process raft request'  (duration: 726.626179ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:23.900804Z","caller":"traceutil/trace.go:171","msg":"trace[849169901] transaction","detail":"{read_only:false; response_revision:26019; number_of_response:1; }","duration":"731.819007ms","start":"2026-07-13T20:54:23.168954Z","end":"2026-07-13T20:54:23.900773Z","steps":["trace[849169901] 'process raft request'  (duration: 134.458311ms)","trace[849169901] 'compare'  (duration: 596.271479ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-13T20:54:23.900841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:23.17388Z","time spent":"726.905777ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:26002 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-07-13T20:54:23.900944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:23.16891Z","time spent":"731.95626ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:26001 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-07-13T20:54:23.90112Z","caller":"traceutil/trace.go:171","msg":"trace[577624835] transaction","detail":"{read_only:false; response_revision:26021; number_of_response:1; }","duration":"418.56835ms","start":"2026-07-13T20:54:23.482541Z","end":"2026-07-13T20:54:23.901109Z","steps":["trace[577624835] 'process raft request'  (duration: 418.099589ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:23.901308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:23.482514Z","time spent":"418.642012ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:26004 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-07-13T20:54:23.901564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.53095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-13T20:54:23.901614Z","caller":"traceutil/trace.go:171","msg":"trace[360184791] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0; response_count:0; response_revision:26020; }","duration":"630.639223ms","start":"2026-07-13T20:54:23.270961Z","end":"2026-07-13T20:54:23.9016Z","steps":["trace[360184791] 'agreement among raft nodes before linearized reading'  (duration: 630.054619ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:23.901651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:23.270939Z","time spent":"630.702934ms","remote":"127.0.0.1:44122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":128,"response count":0,"response size":28,"request content":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true "}
{"level":"warn","ts":"2026-07-13T20:54:23.980031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.45097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-13T20:54:23.980134Z","caller":"traceutil/trace.go:171","msg":"trace[1372904717] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:0; response_revision:26022; }","duration":"428.619924ms","start":"2026-07-13T20:54:23.551493Z","end":"2026-07-13T20:54:23.980113Z","steps":["trace[1372904717] 'agreement among raft nodes before linearized reading'  (duration: 428.430529ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:23.980185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:23.551475Z","time spent":"428.693205ms","remote":"127.0.0.1:56866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" "}
{"level":"warn","ts":"2026-07-13T20:54:23.980246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.765424ms","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-07-13T20:54:23.980307Z","caller":"traceutil/trace.go:171","msg":"trace[849507766] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26022; }","duration":"126.839345ms","start":"2026-07-13T20:54:23.853449Z","end":"2026-07-13T20:54:23.980289Z","steps":["trace[849507766] 'agreement among raft nodes before linearized reading'  (duration: 126.656001ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:23.98003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.057595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-13T20:54:23.980444Z","caller":"traceutil/trace.go:171","msg":"trace[1242178662] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26022; }","duration":"655.536176ms","start":"2026-07-13T20:54:23.324893Z","end":"2026-07-13T20:54:23.98043Z","steps":["trace[1242178662] 'agreement among raft nodes before linearized reading'  (duration: 655.054185ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:23.980485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:23.32487Z","time spent":"655.603937ms","remote":"127.0.0.1:42222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-07-13T20:54:23.980822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.940642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-07-13T20:54:23.980865Z","caller":"traceutil/trace.go:171","msg":"trace[917912375] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26022; }","duration":"128.023824ms","start":"2026-07-13T20:54:23.852831Z","end":"2026-07-13T20:54:23.980855Z","steps":["trace[917912375] 'agreement among raft nodes before linearized reading'  (duration: 127.902292ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:23.982168Z","caller":"traceutil/trace.go:171","msg":"trace[66640597] transaction","detail":"{read_only:false; response_revision:26022; number_of_response:1; }","duration":"224.965036ms","start":"2026-07-13T20:54:23.757184Z","end":"2026-07-13T20:54:23.982149Z","steps":["trace[66640597] 'process raft request'  (duration: 218.905218ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:24.152855Z","caller":"traceutil/trace.go:171","msg":"trace[1257155395] transaction","detail":"{read_only:false; response_revision:26023; number_of_response:1; }","duration":"166.802466ms","start":"2026-07-13T20:54:23.986Z","end":"2026-07-13T20:54:24.152802Z","steps":["trace[1257155395] 'process raft request'  (duration: 135.618599ms)","trace[1257155395] 'compare'  (duration: 31.039652ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:54:24.406659Z","caller":"traceutil/trace.go:171","msg":"trace[391670571] transaction","detail":"{read_only:false; response_revision:26025; number_of_response:1; }","duration":"419.511913ms","start":"2026-07-13T20:54:23.987112Z","end":"2026-07-13T20:54:24.406624Z","steps":["trace[391670571] 'process raft request'  (duration: 419.431141ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:24.406862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:23.987082Z","time spent":"419.680688ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:26009 > 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\" > >"}
{"level":"info","ts":"2026-07-13T20:54:24.407019Z","caller":"traceutil/trace.go:171","msg":"trace[507066213] transaction","detail":"{read_only:false; response_revision:26026; number_of_response:1; }","duration":"419.700697ms","start":"2026-07-13T20:54:23.987259Z","end":"2026-07-13T20:54:24.40696Z","steps":["trace[507066213] 'process raft request'  (duration: 419.325548ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:24.407068Z","caller":"traceutil/trace.go:171","msg":"trace[1539691937] transaction","detail":"{read_only:false; response_revision:26027; number_of_response:1; }","duration":"419.732978ms","start":"2026-07-13T20:54:23.987311Z","end":"2026-07-13T20:54:24.407044Z","steps":["trace[1539691937] 'process raft request'  (duration: 419.541834ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:24.407133Z","caller":"traceutil/trace.go:171","msg":"trace[782838950] linearizableReadLoop","detail":"{readStateIndex:26876; appliedIndex:26871; }","duration":"405.306988ms","start":"2026-07-13T20:54:24.001794Z","end":"2026-07-13T20:54:24.407101Z","steps":["trace[782838950] 'read index received'  (duration: 119.909497ms)","trace[782838950] 'applied index is now lower than readState.Index'  (duration: 285.396621ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:54:24.40716Z","caller":"traceutil/trace.go:171","msg":"trace[565334372] transaction","detail":"{read_only:false; response_revision:26028; number_of_response:1; }","duration":"338.402445ms","start":"2026-07-13T20:54:24.068726Z","end":"2026-07-13T20:54:24.407129Z","steps":["trace[565334372] 'process raft request'  (duration: 338.304393ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:24.407212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:23.987292Z","time spent":"419.826491ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:26012 > 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-07-13T20:54:24.407215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:23.987249Z","time spent":"419.861862ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:26011 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-07-13T20:54:24.407294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:24.068703Z","time spent":"338.52269ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:26014 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-07-13T20:54:24.407412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.612136ms","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-07-13T20:54:24.407462Z","caller":"traceutil/trace.go:171","msg":"trace[1378776441] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26028; }","duration":"405.689547ms","start":"2026-07-13T20:54:24.00176Z","end":"2026-07-13T20:54:24.407449Z","steps":["trace[1378776441] 'agreement among raft nodes before linearized reading'  (duration: 405.482522ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:24.407482Z","caller":"traceutil/trace.go:171","msg":"trace[1271211113] transaction","detail":"{read_only:false; response_revision:26024; number_of_response:1; }","duration":"420.482217ms","start":"2026-07-13T20:54:23.986248Z","end":"2026-07-13T20:54:24.40673Z","steps":["trace[1271211113] 'process raft request'  (duration: 420.076797ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:24.407494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:24.001748Z","time spent":"405.740099ms","remote":"127.0.0.1:42444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12235,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-07-13T20:54:24.407619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:54:23.986242Z","time spent":"421.291396ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:26010 > 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-07-13T20:54:24.531486Z","caller":"traceutil/trace.go:171","msg":"trace[1611563275] linearizableReadLoop","detail":"{readStateIndex:26878; appliedIndex:26877; }","duration":"124.246994ms","start":"2026-07-13T20:54:24.407207Z","end":"2026-07-13T20:54:24.531454Z","steps":["trace[1611563275] 'read index received'  (duration: 117.51448ms)","trace[1611563275] 'applied index is now lower than readState.Index'  (duration: 6.719363ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:54:24.531567Z","caller":"traceutil/trace.go:171","msg":"trace[1967846194] transaction","detail":"{read_only:false; response_revision:26029; number_of_response:1; }","duration":"188.179483ms","start":"2026-07-13T20:54:24.343334Z","end":"2026-07-13T20:54:24.531514Z","steps":["trace[1967846194] 'process raft request'  (duration: 181.49332ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:24.531665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.513888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-13T20:54:24.531733Z","caller":"traceutil/trace.go:171","msg":"trace[1367312998] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26029; }","duration":"206.624081ms","start":"2026-07-13T20:54:24.32509Z","end":"2026-07-13T20:54:24.531714Z","steps":["trace[1367312998] 'agreement among raft nodes before linearized reading'  (duration: 206.489948ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:24.531862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.078294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18227"}
{"level":"info","ts":"2026-07-13T20:54:24.531913Z","caller":"traceutil/trace.go:171","msg":"trace[1765002706] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:26029; }","duration":"123.201777ms","start":"2026-07-13T20:54:24.408698Z","end":"2026-07-13T20:54:24.5319Z","steps":["trace[1765002706] 'agreement among raft nodes before linearized reading'  (duration: 122.955411ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:24.861643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.169919ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757021736260260220 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:26017 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >>","response":"size:18"}
{"level":"warn","ts":"2026-07-13T20:54:24.861668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.656544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-13T20:54:24.861752Z","caller":"traceutil/trace.go:171","msg":"trace[936333668] linearizableReadLoop","detail":"{readStateIndex:26879; appliedIndex:26878; }","duration":"169.599003ms","start":"2026-07-13T20:54:24.692135Z","end":"2026-07-13T20:54:24.861734Z","steps":["trace[936333668] 'read index received'  (duration: 1.192738ms)","trace[936333668] 'applied index is now lower than readState.Index'  (duration: 168.404755ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:54:24.861759Z","caller":"traceutil/trace.go:171","msg":"trace[2115840385] transaction","detail":"{read_only:false; response_revision:26030; number_of_response:1; }","duration":"223.06308ms","start":"2026-07-13T20:54:24.63867Z","end":"2026-07-13T20:54:24.861734Z","steps":["trace[2115840385] 'process raft request'  (duration: 54.718017ms)","trace[2115840385] 'compare'  (duration: 168.034654ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:54:24.861779Z","caller":"traceutil/trace.go:171","msg":"trace[116032251] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26029; }","duration":"229.222358ms","start":"2026-07-13T20:54:24.632529Z","end":"2026-07-13T20:54:24.861751Z","steps":["trace[116032251] 'range keys from in-memory index tree'  (duration: 228.576663ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:24.861857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.713966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-13T20:54:24.8628Z","caller":"traceutil/trace.go:171","msg":"trace[1101640153] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:26030; }","duration":"170.70677ms","start":"2026-07-13T20:54:24.69208Z","end":"2026-07-13T20:54:24.862787Z","steps":["trace[1101640153] 'agreement among raft nodes before linearized reading'  (duration: 169.727507ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:25.330322Z","caller":"traceutil/trace.go:171","msg":"trace[768127632] transaction","detail":"{read_only:false; response_revision:26031; number_of_response:1; }","duration":"150.110581ms","start":"2026-07-13T20:54:25.180183Z","end":"2026-07-13T20:54:25.330294Z","steps":["trace[768127632] 'process raft request'  (duration: 149.936837ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:25.412171Z","caller":"traceutil/trace.go:171","msg":"trace[257837282] transaction","detail":"{read_only:false; response_revision:26032; number_of_response:1; }","duration":"125.234167ms","start":"2026-07-13T20:54:25.286905Z","end":"2026-07-13T20:54:25.412139Z","steps":["trace[257837282] 'process raft request'  (duration: 122.619864ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:28.622661Z","caller":"traceutil/trace.go:171","msg":"trace[1645773306] transaction","detail":"{read_only:false; response_revision:26117; number_of_response:1; }","duration":"126.921217ms","start":"2026-07-13T20:54:28.495693Z","end":"2026-07-13T20:54:28.622614Z","steps":["trace[1645773306] 'process raft request'  (duration: 122.775267ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:28.697039Z","caller":"traceutil/trace.go:171","msg":"trace[1933156687] linearizableReadLoop","detail":"{readStateIndex:26972; appliedIndex:26967; }","duration":"151.471733ms","start":"2026-07-13T20:54:28.545543Z","end":"2026-07-13T20:54:28.697015Z","steps":["trace[1933156687] 'read index received'  (duration: 72.904288ms)","trace[1933156687] 'applied index is now lower than readState.Index'  (duration: 78.566505ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:54:28.697195Z","caller":"traceutil/trace.go:171","msg":"trace[908924580] transaction","detail":"{read_only:false; response_revision:26119; number_of_response:1; }","duration":"201.208449ms","start":"2026-07-13T20:54:28.495936Z","end":"2026-07-13T20:54:28.697144Z","steps":["trace[908924580] 'process raft request'  (duration: 200.960993ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:54:28.697292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.72127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/persistence-rabbitmq-manila-server-0.18c1f4c7a13366e5\" ","response":"range_response_count:1 size:1010"}
{"level":"info","ts":"2026-07-13T20:54:28.697339Z","caller":"traceutil/trace.go:171","msg":"trace[100308819] range","detail":"{range_begin:/registry/events/openstack/persistence-rabbitmq-manila-server-0.18c1f4c7a13366e5; range_end:; response_count:1; response_revision:26121; }","duration":"151.821731ms","start":"2026-07-13T20:54:28.545507Z","end":"2026-07-13T20:54:28.697329Z","steps":["trace[100308819] 'agreement among raft nodes before linearized reading'  (duration: 151.608586ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:28.697536Z","caller":"traceutil/trace.go:171","msg":"trace[1321195707] transaction","detail":"{read_only:false; response_revision:26120; number_of_response:1; }","duration":"201.109367ms","start":"2026-07-13T20:54:28.496419Z","end":"2026-07-13T20:54:28.697529Z","steps":["trace[1321195707] 'process raft request'  (duration: 200.516123ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:28.697601Z","caller":"traceutil/trace.go:171","msg":"trace[1775205361] transaction","detail":"{read_only:false; response_revision:26121; number_of_response:1; }","duration":"153.704958ms","start":"2026-07-13T20:54:28.543891Z","end":"2026-07-13T20:54:28.697596Z","steps":["trace[1775205361] 'process raft request'  (duration: 153.079023ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:28.69772Z","caller":"traceutil/trace.go:171","msg":"trace[1245081756] transaction","detail":"{read_only:false; response_revision:26118; number_of_response:1; }","duration":"201.925236ms","start":"2026-07-13T20:54:28.495777Z","end":"2026-07-13T20:54:28.697702Z","steps":["trace[1245081756] 'process raft request'  (duration: 200.973273ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:33.548177Z","caller":"traceutil/trace.go:171","msg":"trace[590693164] transaction","detail":"{read_only:false; response_revision:26178; number_of_response:1; }","duration":"110.399767ms","start":"2026-07-13T20:54:33.43775Z","end":"2026-07-13T20:54:33.548149Z","steps":["trace[590693164] 'process raft request'  (duration: 110.171491ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:34.078195Z","caller":"traceutil/trace.go:171","msg":"trace[1249893487] transaction","detail":"{read_only:false; response_revision:26181; number_of_response:1; }","duration":"137.225667ms","start":"2026-07-13T20:54:33.940941Z","end":"2026-07-13T20:54:34.078167Z","steps":["trace[1249893487] 'process raft request'  (duration: 137.120285ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:34.078383Z","caller":"traceutil/trace.go:171","msg":"trace[683182003] transaction","detail":"{read_only:false; response_revision:26180; number_of_response:1; }","duration":"138.093169ms","start":"2026-07-13T20:54:33.940186Z","end":"2026-07-13T20:54:34.078279Z","steps":["trace[683182003] 'process raft request'  (duration: 121.819994ms)","trace[683182003] 'compare'  (duration: 15.878695ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:54:41.03235Z","caller":"traceutil/trace.go:171","msg":"trace[2088614993] transaction","detail":"{read_only:false; response_revision:26249; number_of_response:1; }","duration":"115.89074ms","start":"2026-07-13T20:54:40.916411Z","end":"2026-07-13T20:54:41.032302Z","steps":["trace[2088614993] 'process raft request'  (duration: 115.588003ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:41.727785Z","caller":"traceutil/trace.go:171","msg":"trace[1654595402] transaction","detail":"{read_only:false; response_revision:26252; number_of_response:1; }","duration":"146.098763ms","start":"2026-07-13T20:54:41.581662Z","end":"2026-07-13T20:54:41.727761Z","steps":["trace[1654595402] 'process raft request'  (duration: 146.040381ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:41.727811Z","caller":"traceutil/trace.go:171","msg":"trace[861326095] transaction","detail":"{read_only:false; response_revision:26251; number_of_response:1; }","duration":"207.589224ms","start":"2026-07-13T20:54:41.52019Z","end":"2026-07-13T20:54:41.727779Z","steps":["trace[861326095] 'process raft request'  (duration: 206.408806ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:42.159356Z","caller":"traceutil/trace.go:171","msg":"trace[164476969] transaction","detail":"{read_only:false; response_revision:26254; number_of_response:1; }","duration":"123.32245ms","start":"2026-07-13T20:54:42.035984Z","end":"2026-07-13T20:54:42.159307Z","steps":["trace[164476969] 'process raft request'  (duration: 90.799642ms)","trace[164476969] 'compare'  (duration: 32.094178ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:54:42.15943Z","caller":"traceutil/trace.go:171","msg":"trace[1862571457] transaction","detail":"{read_only:false; response_revision:26255; number_of_response:1; }","duration":"108.183232ms","start":"2026-07-13T20:54:42.051206Z","end":"2026-07-13T20:54:42.159389Z","steps":["trace[1862571457] 'process raft request'  (duration: 107.993738ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:44.809413Z","caller":"traceutil/trace.go:171","msg":"trace[317255072] transaction","detail":"{read_only:false; response_revision:26278; number_of_response:1; }","duration":"189.33722ms","start":"2026-07-13T20:54:44.620039Z","end":"2026-07-13T20:54:44.809376Z","steps":["trace[317255072] 'process raft request'  (duration: 189.148866ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:44.810073Z","caller":"traceutil/trace.go:171","msg":"trace[2074743584] linearizableReadLoop","detail":"{readStateIndex:27133; appliedIndex:27133; }","duration":"117.677034ms","start":"2026-07-13T20:54:44.69238Z","end":"2026-07-13T20:54:44.810057Z","steps":["trace[2074743584] 'read index received'  (duration: 117.670894ms)","trace[2074743584] 'applied index is now lower than readState.Index'  (duration: 4.93µs)"],"step_count":2}
{"level":"warn","ts":"2026-07-13T20:54:44.810333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.93536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-07-13T20:54:44.810424Z","caller":"traceutil/trace.go:171","msg":"trace[19739508] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26278; }","duration":"118.086434ms","start":"2026-07-13T20:54:44.692316Z","end":"2026-07-13T20:54:44.810402Z","steps":["trace[19739508] 'agreement among raft nodes before linearized reading'  (duration: 117.820828ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:44.859231Z","caller":"traceutil/trace.go:171","msg":"trace[42116084] transaction","detail":"{read_only:false; response_revision:26279; number_of_response:1; }","duration":"104.653457ms","start":"2026-07-13T20:54:44.754535Z","end":"2026-07-13T20:54:44.859189Z","steps":["trace[42116084] 'process raft request'  (duration: 104.370031ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:45.032996Z","caller":"traceutil/trace.go:171","msg":"trace[1218859927] transaction","detail":"{read_only:false; response_revision:26280; number_of_response:1; }","duration":"218.019807ms","start":"2026-07-13T20:54:44.814954Z","end":"2026-07-13T20:54:45.032974Z","steps":["trace[1218859927] 'process raft request'  (duration: 118.245537ms)","trace[1218859927] 'compare'  (duration: 99.410221ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:54:45.033333Z","caller":"traceutil/trace.go:171","msg":"trace[237569853] transaction","detail":"{read_only:false; response_revision:26281; number_of_response:1; }","duration":"215.971077ms","start":"2026-07-13T20:54:44.817344Z","end":"2026-07-13T20:54:45.033315Z","steps":["trace[237569853] 'process raft request'  (duration: 215.590468ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:45.033754Z","caller":"traceutil/trace.go:171","msg":"trace[2126030800] transaction","detail":"{read_only:false; response_revision:26282; number_of_response:1; }","duration":"168.837404ms","start":"2026-07-13T20:54:44.864906Z","end":"2026-07-13T20:54:45.033744Z","steps":["trace[2126030800] 'process raft request'  (duration: 168.350723ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:45.033913Z","caller":"traceutil/trace.go:171","msg":"trace[1583731259] transaction","detail":"{read_only:false; response_revision:26283; number_of_response:1; }","duration":"168.922596ms","start":"2026-07-13T20:54:44.864965Z","end":"2026-07-13T20:54:45.033888Z","steps":["trace[1583731259] 'process raft request'  (duration: 168.68987ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:45.03404Z","caller":"traceutil/trace.go:171","msg":"trace[1310185515] transaction","detail":"{read_only:false; response_revision:26284; number_of_response:1; }","duration":"169.052359ms","start":"2026-07-13T20:54:44.864978Z","end":"2026-07-13T20:54:45.034031Z","steps":["trace[1310185515] 'process raft request'  (duration: 168.870225ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:51.88251Z","caller":"traceutil/trace.go:171","msg":"trace[713767582] transaction","detail":"{read_only:false; response_revision:26346; number_of_response:1; }","duration":"100.18974ms","start":"2026-07-13T20:54:51.782294Z","end":"2026-07-13T20:54:51.882484Z","steps":["trace[713767582] 'process raft request'  (duration: 100.061907ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:54:58.091426Z","caller":"traceutil/trace.go:171","msg":"trace[814563571] transaction","detail":"{read_only:false; response_revision:26402; number_of_response:1; }","duration":"102.199968ms","start":"2026-07-13T20:54:57.989186Z","end":"2026-07-13T20:54:58.091386Z","steps":["trace[814563571] 'process raft request'  (duration: 27.554768ms)","trace[814563571] 'compare'  (duration: 74.359013ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:55:00.227851Z","caller":"traceutil/trace.go:171","msg":"trace[352668418] transaction","detail":"{read_only:false; response_revision:26422; number_of_response:1; }","duration":"122.075889ms","start":"2026-07-13T20:55:00.105753Z","end":"2026-07-13T20:55:00.227829Z","steps":["trace[352668418] 'process raft request'  (duration: 115.161632ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:55:05.239611Z","caller":"traceutil/trace.go:171","msg":"trace[448722536] linearizableReadLoop","detail":"{readStateIndex:27338; appliedIndex:27337; }","duration":"173.795665ms","start":"2026-07-13T20:55:05.065779Z","end":"2026-07-13T20:55:05.239575Z","steps":["trace[448722536] 'read index received'  (duration: 173.60819ms)","trace[448722536] 'applied index is now lower than readState.Index'  (duration: 185.605µs)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:55:05.239687Z","caller":"traceutil/trace.go:171","msg":"trace[1349193261] transaction","detail":"{read_only:false; response_revision:26479; number_of_response:1; }","duration":"302.207719ms","start":"2026-07-13T20:55:04.937438Z","end":"2026-07-13T20:55:05.239646Z","steps":["trace[1349193261] 'process raft request'  (duration: 301.888541ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:55:05.239868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:55:04.937418Z","time spent":"302.353513ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:26462 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-07-13T20:55:05.23997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.153443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/heat-engine-cleaner-29732935-mndr4\" ","response":"range_response_count:1 size:7229"}
{"level":"info","ts":"2026-07-13T20:55:05.240009Z","caller":"traceutil/trace.go:171","msg":"trace[562174243] range","detail":"{range_begin:/registry/pods/openstack/heat-engine-cleaner-29732935-mndr4; range_end:; response_count:1; response_revision:26479; }","duration":"174.279476ms","start":"2026-07-13T20:55:05.065715Z","end":"2026-07-13T20:55:05.239995Z","steps":["trace[562174243] 'agreement among raft nodes before linearized reading'  (duration: 174.03023ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:55:05.275209Z","caller":"traceutil/trace.go:171","msg":"trace[1389523760] transaction","detail":"{read_only:false; response_revision:26480; number_of_response:1; }","duration":"108.641124ms","start":"2026-07-13T20:55:05.166534Z","end":"2026-07-13T20:55:05.275175Z","steps":["trace[1389523760] 'process raft request'  (duration: 108.236024ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:55:05.275417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.98846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-07-13T20:55:05.275485Z","caller":"traceutil/trace.go:171","msg":"trace[1737334787] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26480; }","duration":"106.122603ms","start":"2026-07-13T20:55:05.169343Z","end":"2026-07-13T20:55:05.275466Z","steps":["trace[1737334787] 'agreement among raft nodes before linearized reading'  (duration: 105.853727ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:55:05.278146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.066405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-07-13T20:55:05.278298Z","caller":"traceutil/trace.go:171","msg":"trace[2020019255] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26480; }","duration":"109.29152ms","start":"2026-07-13T20:55:05.168979Z","end":"2026-07-13T20:55:05.27827Z","steps":["trace[2020019255] 'agreement among raft nodes before linearized reading'  (duration: 106.046812ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:55:06.312665Z","caller":"traceutil/trace.go:171","msg":"trace[531622918] transaction","detail":"{read_only:false; response_revision:26487; number_of_response:1; }","duration":"164.833917ms","start":"2026-07-13T20:55:06.147818Z","end":"2026-07-13T20:55:06.312652Z","steps":["trace[531622918] 'process raft request'  (duration: 164.747275ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:55:08.446895Z","caller":"traceutil/trace.go:171","msg":"trace[1248813661] transaction","detail":"{read_only:false; response_revision:26505; number_of_response:1; }","duration":"127.287845ms","start":"2026-07-13T20:55:08.31958Z","end":"2026-07-13T20:55:08.446867Z","steps":["trace[1248813661] 'process raft request'  (duration: 127.129362ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:55:08.613095Z","caller":"traceutil/trace.go:171","msg":"trace[687169859] transaction","detail":"{read_only:false; response_revision:26506; number_of_response:1; }","duration":"288.186668ms","start":"2026-07-13T20:55:08.324882Z","end":"2026-07-13T20:55:08.613069Z","steps":["trace[687169859] 'process raft request'  (duration: 286.826095ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:55:08.613352Z","caller":"traceutil/trace.go:171","msg":"trace[1776801174] transaction","detail":"{read_only:false; response_revision:26507; number_of_response:1; }","duration":"286.550258ms","start":"2026-07-13T20:55:08.326767Z","end":"2026-07-13T20:55:08.613317Z","steps":["trace[1776801174] 'process raft request'  (duration: 286.239701ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:55:08.613612Z","caller":"traceutil/trace.go:171","msg":"trace[163035076] transaction","detail":"{read_only:false; response_revision:26508; number_of_response:1; }","duration":"286.621601ms","start":"2026-07-13T20:55:08.32698Z","end":"2026-07-13T20:55:08.613602Z","steps":["trace[163035076] 'process raft request'  (duration: 286.235861ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:55:08.613956Z","caller":"traceutil/trace.go:171","msg":"trace[1167361909] linearizableReadLoop","detail":"{readStateIndex:27369; appliedIndex:27364; }","duration":"243.015723ms","start":"2026-07-13T20:55:08.370917Z","end":"2026-07-13T20:55:08.613932Z","steps":["trace[1167361909] 'read index received'  (duration: 75.822848ms)","trace[1167361909] 'applied index is now lower than readState.Index'  (duration: 167.191835ms)"],"step_count":2}
{"level":"info","ts":"2026-07-13T20:55:08.614116Z","caller":"traceutil/trace.go:171","msg":"trace[781764833] transaction","detail":"{read_only:false; response_revision:26509; number_of_response:1; }","duration":"286.792635ms","start":"2026-07-13T20:55:08.327309Z","end":"2026-07-13T20:55:08.614102Z","steps":["trace[781764833] 'process raft request'  (duration: 286.255352ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:55:08.61417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.655961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-13T20:55:08.614225Z","caller":"traceutil/trace.go:171","msg":"trace[1430663202] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:26509; }","duration":"206.763234ms","start":"2026-07-13T20:55:08.407447Z","end":"2026-07-13T20:55:08.61421Z","steps":["trace[1430663202] 'agreement among raft nodes before linearized reading'  (duration: 206.667511ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-13T20:55:08.614301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.376162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-07-13T20:55:08.614375Z","caller":"traceutil/trace.go:171","msg":"trace[163623465] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26509; }","duration":"243.499994ms","start":"2026-07-13T20:55:08.370862Z","end":"2026-07-13T20:55:08.614362Z","steps":["trace[163623465] 'agreement among raft nodes before linearized reading'  (duration: 243.30967ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:55:13.710879Z","caller":"traceutil/trace.go:171","msg":"trace[1556992821] transaction","detail":"{read_only:false; response_revision:26563; number_of_response:1; }","duration":"180.557748ms","start":"2026-07-13T20:55:13.530294Z","end":"2026-07-13T20:55:13.710852Z","steps":["trace[1556992821] 'process raft request'  (duration: 158.961204ms)","trace[1556992821] 'compare'  (duration: 21.43108ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-13T20:55:21.343517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.869101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/ports/\" range_end:\"/registry/openstack.k-orc.cloud/ports0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-07-13T20:55:21.343551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.806895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-13T20:55:21.343622Z","caller":"traceutil/trace.go:171","msg":"trace[674892359] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/ports/; range_end:/registry/openstack.k-orc.cloud/ports0; response_count:0; response_revision:26627; }","duration":"140.003075ms","start":"2026-07-13T20:55:21.203598Z","end":"2026-07-13T20:55:21.343601Z","steps":["trace[674892359] 'count revisions from in-memory index tree'  (duration: 139.82123ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:55:21.343639Z","caller":"traceutil/trace.go:171","msg":"trace[1083011992] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26627; }","duration":"145.935449ms","start":"2026-07-13T20:55:21.197682Z","end":"2026-07-13T20:55:21.343617Z","steps":["trace[1083011992] 'range keys from in-memory index tree'  (duration: 145.664322ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:57:48.876175Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25111}
{"level":"info","ts":"2026-07-13T20:57:49.018984Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25111,"took":"137.431465ms","hash":2459071750,"current-db-size-bytes":58331136,"current-db-size":"58 MB","current-db-size-in-use-bytes":37986304,"current-db-size-in-use":"38 MB"}
{"level":"info","ts":"2026-07-13T20:57:49.019094Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2459071750,"revision":25111,"compact-revision":21935}
{"level":"info","ts":"2026-07-13T20:59:06.772221Z","caller":"traceutil/trace.go:171","msg":"trace[772022675] transaction","detail":"{read_only:false; response_revision:28910; number_of_response:1; }","duration":"123.780415ms","start":"2026-07-13T20:59:06.648416Z","end":"2026-07-13T20:59:06.772196Z","steps":["trace[772022675] 'process raft request'  (duration: 123.54046ms)"],"step_count":1}
{"level":"info","ts":"2026-07-13T20:59:24.933854Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"331455d6226d3423","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-13T20:59:24.938694Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-07-13T20:59:24.938799Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-07-13T21:02:48.883381Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28070}
{"level":"info","ts":"2026-07-13T21:02:49.040518Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28070,"took":"150.648385ms","hash":3652699744,"current-db-size-bytes":58331136,"current-db-size":"58 MB","current-db-size-in-use-bytes":34488320,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-07-13T21:02:49.040605Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3652699744,"revision":28070,"compact-revision":25111}
{"level":"info","ts":"2026-07-13T21:07:48.889885Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30708}
{"level":"info","ts":"2026-07-13T21:07:49.026824Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30708,"took":"132.729917ms","hash":1537941291,"current-db-size-bytes":58331136,"current-db-size":"58 MB","current-db-size-in-use-bytes":32022528,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-07-13T21:07:49.02698Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1537941291,"revision":30708,"compact-revision":28070}
{"level":"info","ts":"2026-07-13T21:12:48.896102Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33014}
{"level":"info","ts":"2026-07-13T21:12:49.051276Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33014,"took":"150.733813ms","hash":1534602302,"current-db-size-bytes":59375616,"current-db-size":"59 MB","current-db-size-in-use-bytes":31555584,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-07-13T21:12:49.051374Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1534602302,"revision":33014,"compact-revision":30708}
{"level":"info","ts":"2026-07-13T21:17:48.905957Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35266}
{"level":"info","ts":"2026-07-13T21:17:49.050722Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35266,"took":"141.078289ms","hash":3753373372,"current-db-size-bytes":59375616,"current-db-size":"59 MB","current-db-size-in-use-bytes":31121408,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-07-13T21:17:49.050803Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3753373372,"revision":35266,"compact-revision":33014}
{"level":"info","ts":"2026-07-13T21:20:25.063455Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"331455d6226d3423","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-13T21:20:25.067999Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-07-13T21:20:25.068116Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-07-13T21:22:48.912836Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37576}
{"level":"info","ts":"2026-07-13T21:22:49.032671Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37576,"took":"115.919116ms","hash":3625092240,"current-db-size-bytes":59375616,"current-db-size":"59 MB","current-db-size-in-use-bytes":31674368,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-07-13T21:22:49.032737Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3625092240,"revision":37576,"compact-revision":35266}