{"level":"warn","ts":"2026-08-06T01:03:55.122399Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-06T01:03:55.122571Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.5: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.19.213.5:2380","--initial-cluster=instance=https://199.19.213.5:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.5:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.5: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-08-06T01:03:55.122738Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-06T01:03:55.122768Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.5:2380"]}
{"level":"info","ts":"2026-08-06T01:03:55.122809Z","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-08-06T01:03:55.124587Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.5:2379"]}
{"level":"info","ts":"2026-08-06T01:03:55.124755Z","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.19.213.5:2380"],"listen-peer-urls":["https://199.19.213.5:2380"],"advertise-client-urls":["https://199.19.213.5:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.5:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.5: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-08-06T01:03:55.127224Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.01947ms"}
{"level":"info","ts":"2026-08-06T01:03:55.133495Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"dcb0af7a3afe1d6d","cluster-id":"4564295d4e5c9a3e"}
{"level":"info","ts":"2026-08-06T01:03:55.133572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d switched to configuration voters=()"}
{"level":"info","ts":"2026-08-06T01:03:55.133597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d became follower at term 0"}
{"level":"info","ts":"2026-08-06T01:03:55.133614Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft dcb0af7a3afe1d6d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-08-06T01:03:55.133625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d became follower at term 1"}
{"level":"info","ts":"2026-08-06T01:03:55.133666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d switched to configuration voters=(15902403223755824493)"}
{"level":"warn","ts":"2026-08-06T01:03:55.137983Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-08-06T01:03:55.13982Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-08-06T01:03:55.141091Z","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-08-06T01:03:55.143975Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"dcb0af7a3afe1d6d","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-08-06T01:03:55.144172Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"dcb0af7a3afe1d6d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-08-06T01:03:55.144501Z","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-08-06T01:03:55.144608Z","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-08-06T01:03:55.144625Z","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-08-06T01:03:55.15151Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d switched to configuration voters=(15902403223755824493)"}
{"level":"info","ts":"2026-08-06T01:03:55.151722Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4564295d4e5c9a3e","local-member-id":"dcb0af7a3afe1d6d","added-peer-id":"dcb0af7a3afe1d6d","added-peer-peer-urls":["https://199.19.213.5:2380"]}
{"level":"info","ts":"2026-08-06T01:03:55.152313Z","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-08-06T01:03:55.152608Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"dcb0af7a3afe1d6d","initial-advertise-peer-urls":["https://199.19.213.5:2380"],"listen-peer-urls":["https://199.19.213.5:2380"],"advertise-client-urls":["https://199.19.213.5:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.5:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-08-06T01:03:55.152657Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-08-06T01:03:55.152752Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.5:2380"}
{"level":"info","ts":"2026-08-06T01:03:55.152775Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.5:2380"}
{"level":"info","ts":"2026-08-06T01:03:56.034889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d is starting a new election at term 1"}
{"level":"info","ts":"2026-08-06T01:03:56.034965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d became pre-candidate at term 1"}
{"level":"info","ts":"2026-08-06T01:03:56.035012Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d received MsgPreVoteResp from dcb0af7a3afe1d6d at term 1"}
{"level":"info","ts":"2026-08-06T01:03:56.035037Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d became candidate at term 2"}
{"level":"info","ts":"2026-08-06T01:03:56.035051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d received MsgVoteResp from dcb0af7a3afe1d6d at term 2"}
{"level":"info","ts":"2026-08-06T01:03:56.035068Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d became leader at term 2"}
{"level":"info","ts":"2026-08-06T01:03:56.035089Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: dcb0af7a3afe1d6d elected leader dcb0af7a3afe1d6d at term 2"}
{"level":"info","ts":"2026-08-06T01:03:56.035951Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-06T01:03:56.036728Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-06T01:03:56.036785Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-06T01:03:56.036723Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"dcb0af7a3afe1d6d","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.5:2379]}","request-path":"/0/members/dcb0af7a3afe1d6d/attributes","cluster-id":"4564295d4e5c9a3e","publish-timeout":"7s"}
{"level":"info","ts":"2026-08-06T01:03:56.037092Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-08-06T01:03:56.037214Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4564295d4e5c9a3e","local-member-id":"dcb0af7a3afe1d6d","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-06T01:03:56.037231Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-08-06T01:03:56.037345Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-06T01:03:56.037389Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-06T01:03:56.040129Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-08-06T01:03:56.043418Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.5:2379"}
{"level":"warn","ts":"2026-08-06T01:04:17.659198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.270473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-08-06T01:04:17.659387Z","caller":"traceutil/trace.go:171","msg":"trace[920624561] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:383; }","duration":"139.525017ms","start":"2026-08-06T01:04:17.519834Z","end":"2026-08-06T01:04:17.659359Z","steps":["trace[920624561] 'range keys from in-memory index tree'  (duration: 139.13846ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:04:32.812861Z","caller":"traceutil/trace.go:171","msg":"trace[2025268024] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"100.532632ms","start":"2026-08-06T01:04:32.712272Z","end":"2026-08-06T01:04:32.812804Z","steps":["trace[2025268024] 'process raft request'  (duration: 96.686146ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:04:38.731341Z","caller":"traceutil/trace.go:171","msg":"trace[1350877571] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"144.352182ms","start":"2026-08-06T01:04:38.586946Z","end":"2026-08-06T01:04:38.731298Z","steps":["trace[1350877571] 'process raft request'  (duration: 117.773416ms)","trace[1350877571] 'compare'  (duration: 26.28163ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:04:38.819406Z","caller":"traceutil/trace.go:171","msg":"trace[704876895] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:610; }","duration":"161.378803ms","start":"2026-08-06T01:04:38.658001Z","end":"2026-08-06T01:04:38.81938Z","steps":["trace[704876895] 'read index received'  (duration: 46.725077ms)","trace[704876895] 'applied index is now lower than readState.Index'  (duration: 114.652386ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:04:38.819517Z","caller":"traceutil/trace.go:171","msg":"trace[127031374] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"194.079737ms","start":"2026-08-06T01:04:38.625413Z","end":"2026-08-06T01:04:38.819493Z","steps":["trace[127031374] 'process raft request'  (duration: 193.812192ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:04:38.81959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.575226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jqhsj\" ","response":"range_response_count:1 size:16957"}
{"level":"info","ts":"2026-08-06T01:04:38.819625Z","caller":"traceutil/trace.go:171","msg":"trace[1687494929] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jqhsj; range_end:; response_count:1; response_revision:590; }","duration":"161.676308ms","start":"2026-08-06T01:04:38.657938Z","end":"2026-08-06T01:04:38.819614Z","steps":["trace[1687494929] 'agreement among raft nodes before linearized reading'  (duration: 161.550666ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:04:39.172377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.831086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-06T01:04:39.172467Z","caller":"traceutil/trace.go:171","msg":"trace[458797652] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:590; }","duration":"340.961148ms","start":"2026-08-06T01:04:38.831483Z","end":"2026-08-06T01:04:39.172445Z","steps":["trace[458797652] 'range keys from in-memory index tree'  (duration: 340.752375ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:04:39.172508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:04:38.831466Z","time spent":"341.03344ms","remote":"127.0.0.1:51988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "}
{"level":"warn","ts":"2026-08-06T01:04:39.173546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.704962ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2120526735012856364 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/cilium-jqhsj\" mod_revision:476 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-jqhsj\" value_size:17077 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-jqhsj\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-06T01:04:39.173707Z","caller":"traceutil/trace.go:171","msg":"trace[1759997878] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"342.06048ms","start":"2026-08-06T01:04:38.831613Z","end":"2026-08-06T01:04:39.173674Z","steps":["trace[1759997878] 'process raft request'  (duration: 185.603153ms)","trace[1759997878] 'compare'  (duration: 155.514869ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-06T01:04:39.17406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:04:38.831584Z","time spent":"342.198202ms","remote":"127.0.0.1:51926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17126,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-jqhsj\" mod_revision:476 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-jqhsj\" value_size:17077 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-jqhsj\" > >"}
{"level":"info","ts":"2026-08-06T01:04:39.173727Z","caller":"traceutil/trace.go:171","msg":"trace[807746] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"273.60819ms","start":"2026-08-06T01:04:38.900095Z","end":"2026-08-06T01:04:39.173703Z","steps":["trace[807746] 'read index received'  (duration: 117.039272ms)","trace[807746] 'applied index is now lower than readState.Index'  (duration: 156.566348ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-06T01:04:39.174157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.0398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-06T01:04:39.174292Z","caller":"traceutil/trace.go:171","msg":"trace[1009398200] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:591; }","duration":"274.216883ms","start":"2026-08-06T01:04:38.900039Z","end":"2026-08-06T01:04:39.174256Z","steps":["trace[1009398200] 'agreement among raft nodes before linearized reading'  (duration: 274.012249ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:04:39.174556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.251045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.5\" ","response":"range_response_count:1 size:131"}
{"level":"info","ts":"2026-08-06T01:04:39.174659Z","caller":"traceutil/trace.go:171","msg":"trace[298425717] range","detail":"{range_begin:/registry/masterleases/199.19.213.5; range_end:; response_count:1; response_revision:591; }","duration":"188.336926ms","start":"2026-08-06T01:04:38.986268Z","end":"2026-08-06T01:04:39.174605Z","steps":["trace[298425717] 'agreement among raft nodes before linearized reading'  (duration: 188.077391ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:04:39.62677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.499619ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2120526735012856370 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.19.213.5\" mod_revision:440 > success:<request_put:<key:\"/registry/masterleases/199.19.213.5\" value_size:65 lease:2120526735012856367 >> failure:<request_range:<key:\"/registry/masterleases/199.19.213.5\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-06T01:04:39.626891Z","caller":"traceutil/trace.go:171","msg":"trace[70399572] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:614; }","duration":"129.646756ms","start":"2026-08-06T01:04:39.497228Z","end":"2026-08-06T01:04:39.626875Z","steps":["trace[70399572] 'read index received'  (duration: 49.421µs)","trace[70399572] 'applied index is now lower than readState.Index'  (duration: 129.596045ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:04:39.626915Z","caller":"traceutil/trace.go:171","msg":"trace[847234455] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"406.175724ms","start":"2026-08-06T01:04:39.220717Z","end":"2026-08-06T01:04:39.626892Z","steps":["trace[847234455] 'process raft request'  (duration: 217.466671ms)","trace[847234455] 'compare'  (duration: 188.330796ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-06T01:04:39.627014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:04:39.220674Z","time spent":"406.294556ms","remote":"127.0.0.1:51780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":116,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.19.213.5\" mod_revision:440 > success:<request_put:<key:\"/registry/masterleases/199.19.213.5\" value_size:65 lease:2120526735012856367 >> failure:<request_range:<key:\"/registry/masterleases/199.19.213.5\" > >"}
{"level":"warn","ts":"2026-08-06T01:04:39.627073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.83958ms","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-08-06T01:04:39.627117Z","caller":"traceutil/trace.go:171","msg":"trace[1424663516] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:592; }","duration":"129.911062ms","start":"2026-08-06T01:04:39.497192Z","end":"2026-08-06T01:04:39.627103Z","steps":["trace[1424663516] 'agreement among raft nodes before linearized reading'  (duration: 129.732748ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:05:25.178832Z","caller":"traceutil/trace.go:171","msg":"trace[5655869] transaction","detail":"{read_only:false; response_revision:1157; number_of_response:1; }","duration":"223.519989ms","start":"2026-08-06T01:05:24.955282Z","end":"2026-08-06T01:05:25.178802Z","steps":["trace[5655869] 'process raft request'  (duration: 223.319006ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:05:46.182906Z","caller":"traceutil/trace.go:171","msg":"trace[1847774307] transaction","detail":"{read_only:false; response_revision:1412; number_of_response:1; }","duration":"115.995647ms","start":"2026-08-06T01:05:46.066868Z","end":"2026-08-06T01:05:46.182863Z","steps":["trace[1847774307] 'process raft request'  (duration: 101.323991ms)","trace[1847774307] 'compare'  (duration: 14.299068ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:06:10.061574Z","caller":"traceutil/trace.go:171","msg":"trace[1981740625] linearizableReadLoop","detail":"{readStateIndex:1888; appliedIndex:1887; }","duration":"216.457033ms","start":"2026-08-06T01:06:09.84509Z","end":"2026-08-06T01:06:10.061547Z","steps":["trace[1981740625] 'read index received'  (duration: 216.268048ms)","trace[1981740625] 'applied index is now lower than readState.Index'  (duration: 187.895µs)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:06:10.061653Z","caller":"traceutil/trace.go:171","msg":"trace[405770317] transaction","detail":"{read_only:false; response_revision:1817; number_of_response:1; }","duration":"328.964571ms","start":"2026-08-06T01:06:09.732658Z","end":"2026-08-06T01:06:10.061622Z","steps":["trace[405770317] 'process raft request'  (duration: 328.712755ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:06:10.061808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:06:09.732634Z","time spent":"329.090343ms","remote":"127.0.0.1:52024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1796 > 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-08-06T01:06:10.061801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.697167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ac7dc29d-c625-4830-b8fc-e8790f1079e6\" ","response":"range_response_count:1 size:3625"}
{"level":"info","ts":"2026-08-06T01:06:10.061858Z","caller":"traceutil/trace.go:171","msg":"trace[877164584] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ac7dc29d-c625-4830-b8fc-e8790f1079e6; range_end:; response_count:1; response_revision:1817; }","duration":"216.804918ms","start":"2026-08-06T01:06:09.845039Z","end":"2026-08-06T01:06:10.061844Z","steps":["trace[877164584] 'agreement among raft nodes before linearized reading'  (duration: 216.638575ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:06:10.07323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.548377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-06T01:06:10.073311Z","caller":"traceutil/trace.go:171","msg":"trace[1898789568] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1818; }","duration":"172.66659ms","start":"2026-08-06T01:06:09.900624Z","end":"2026-08-06T01:06:10.07329Z","steps":["trace[1898789568] 'agreement among raft nodes before linearized reading'  (duration: 172.527757ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:06:10.478101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.223285ms","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-08-06T01:06:10.478344Z","caller":"traceutil/trace.go:171","msg":"trace[256564940] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1823; }","duration":"108.48587ms","start":"2026-08-06T01:06:10.369834Z","end":"2026-08-06T01:06:10.47832Z","steps":["trace[256564940] 'range keys from in-memory index tree'  (duration: 108.201875ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:06:10.478484Z","caller":"traceutil/trace.go:171","msg":"trace[1528563994] transaction","detail":"{read_only:false; response_revision:1824; number_of_response:1; }","duration":"159.440832ms","start":"2026-08-06T01:06:10.31901Z","end":"2026-08-06T01:06:10.478451Z","steps":["trace[1528563994] 'process raft request'  (duration: 74.586901ms)","trace[1528563994] 'compare'  (duration: 84.641357ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:06:10.478587Z","caller":"traceutil/trace.go:171","msg":"trace[1372309951] transaction","detail":"{read_only:false; response_revision:1825; number_of_response:1; }","duration":"157.341451ms","start":"2026-08-06T01:06:10.321219Z","end":"2026-08-06T01:06:10.478561Z","steps":["trace[1372309951] 'process raft request'  (duration: 157.190948ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:06:25.042237Z","caller":"traceutil/trace.go:171","msg":"trace[1325504297] transaction","detail":"{read_only:false; response_revision:1939; number_of_response:1; }","duration":"141.309162ms","start":"2026-08-06T01:06:24.9009Z","end":"2026-08-06T01:06:25.042209Z","steps":["trace[1325504297] 'process raft request'  (duration: 141.135618ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:06:59.254696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.542078ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2120526735012859519 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.19.213.5\" mod_revision:2082 > success:<request_put:<key:\"/registry/masterleases/199.19.213.5\" value_size:65 lease:2120526735012859516 >> failure:<request_range:<key:\"/registry/masterleases/199.19.213.5\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-06T01:06:59.25496Z","caller":"traceutil/trace.go:171","msg":"trace[668150536] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"162.079117ms","start":"2026-08-06T01:06:59.09286Z","end":"2026-08-06T01:06:59.254939Z","steps":["trace[668150536] 'process raft request'  (duration: 32.190213ms)","trace[668150536] 'compare'  (duration: 129.320244ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:08:12.547334Z","caller":"traceutil/trace.go:171","msg":"trace[274232051] transaction","detail":"{read_only:false; response_revision:2728; number_of_response:1; }","duration":"123.463581ms","start":"2026-08-06T01:08:12.42384Z","end":"2026-08-06T01:08:12.547303Z","steps":["trace[274232051] 'process raft request'  (duration: 123.283157ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:08:12.768054Z","caller":"traceutil/trace.go:171","msg":"trace[219370142] transaction","detail":"{read_only:false; response_revision:2730; number_of_response:1; }","duration":"235.037472ms","start":"2026-08-06T01:08:12.532975Z","end":"2026-08-06T01:08:12.768013Z","steps":["trace[219370142] 'process raft request'  (duration: 234.91364ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:08:12.768353Z","caller":"traceutil/trace.go:171","msg":"trace[122932585] transaction","detail":"{read_only:false; response_revision:2729; number_of_response:1; }","duration":"245.792879ms","start":"2026-08-06T01:08:12.522531Z","end":"2026-08-06T01:08:12.768324Z","steps":["trace[122932585] 'process raft request'  (duration: 186.42704ms)","trace[122932585] 'compare'  (duration: 58.798748ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:10:37.810351Z","caller":"traceutil/trace.go:171","msg":"trace[589692168] transaction","detail":"{read_only:false; response_revision:3694; number_of_response:1; }","duration":"118.491844ms","start":"2026-08-06T01:10:37.691827Z","end":"2026-08-06T01:10:37.810319Z","steps":["trace[589692168] 'process raft request'  (duration: 118.241509ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:11:33.725844Z","caller":"traceutil/trace.go:171","msg":"trace[306890528] transaction","detail":"{read_only:false; response_revision:4079; number_of_response:1; }","duration":"174.699837ms","start":"2026-08-06T01:11:33.551103Z","end":"2026-08-06T01:11:33.725803Z","steps":["trace[306890528] 'process raft request'  (duration: 173.469903ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:11:33.725922Z","caller":"traceutil/trace.go:171","msg":"trace[1139128528] transaction","detail":"{read_only:false; response_revision:4080; number_of_response:1; }","duration":"174.124105ms","start":"2026-08-06T01:11:33.551754Z","end":"2026-08-06T01:11:33.725878Z","steps":["trace[1139128528] 'process raft request'  (duration: 173.932831ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:11:59.90144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.27707ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2120526735012866142 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/namespaces/monitoring\" mod_revision:0 > success:<request_put:<key:\"/registry/namespaces/monitoring\" value_size:318 >> failure:<>>","response":"size:5"}
{"level":"info","ts":"2026-08-06T01:11:59.901741Z","caller":"traceutil/trace.go:171","msg":"trace[2004559001] transaction","detail":"{read_only:false; number_of_response:0; response_revision:4860; }","duration":"139.882448ms","start":"2026-08-06T01:11:59.761817Z","end":"2026-08-06T01:11:59.9017Z","steps":["trace[2004559001] 'compare'  (duration: 126.238339ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:12:00.097348Z","caller":"traceutil/trace.go:171","msg":"trace[186009028] linearizableReadLoop","detail":"{readStateIndex:5053; appliedIndex:5052; }","duration":"188.8418ms","start":"2026-08-06T01:11:59.908473Z","end":"2026-08-06T01:12:00.097314Z","steps":["trace[186009028] 'read index received'  (duration: 125.871003ms)","trace[186009028] 'applied index is now lower than readState.Index'  (duration: 62.969397ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:12:00.097471Z","caller":"traceutil/trace.go:171","msg":"trace[1223457945] transaction","detail":"{read_only:false; response_revision:4863; number_of_response:1; }","duration":"189.219957ms","start":"2026-08-06T01:11:59.908198Z","end":"2026-08-06T01:12:00.097418Z","steps":["trace[1223457945] 'process raft request'  (duration: 126.2762ms)","trace[1223457945] 'compare'  (duration: 62.693842ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-06T01:12:00.097708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.194686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/monitoring\" ","response":"range_response_count:1 size:372"}
{"level":"info","ts":"2026-08-06T01:12:00.097796Z","caller":"traceutil/trace.go:171","msg":"trace[828640766] range","detail":"{range_begin:/registry/namespaces/monitoring; range_end:; response_count:1; response_revision:4863; }","duration":"189.350898ms","start":"2026-08-06T01:11:59.908425Z","end":"2026-08-06T01:12:00.097776Z","steps":["trace[828640766] 'agreement among raft nodes before linearized reading'  (duration: 189.045163ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:12:00.097772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.031264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-08-06T01:12:00.097834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.6902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d964f107-71f6-4ac3-97ec-f6af2a64ff6d\" ","response":"range_response_count:1 size:3599"}
{"level":"info","ts":"2026-08-06T01:12:00.097879Z","caller":"traceutil/trace.go:171","msg":"trace[819363618] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:4863; }","duration":"107.185408ms","start":"2026-08-06T01:11:59.990671Z","end":"2026-08-06T01:12:00.097856Z","steps":["trace[819363618] 'agreement among raft nodes before linearized reading'  (duration: 106.957854ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:12:00.097878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.604198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d964f107-71f6-4ac3-97ec-f6af2a64ff6d\" ","response":"range_response_count:1 size:3599"}
{"level":"info","ts":"2026-08-06T01:12:00.097979Z","caller":"traceutil/trace.go:171","msg":"trace[186447221] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d964f107-71f6-4ac3-97ec-f6af2a64ff6d; range_end:; response_count:1; response_revision:4863; }","duration":"115.750571ms","start":"2026-08-06T01:11:59.98221Z","end":"2026-08-06T01:12:00.097961Z","steps":["trace[186447221] 'agreement among raft nodes before linearized reading'  (duration: 115.425345ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:12:00.097923Z","caller":"traceutil/trace.go:171","msg":"trace[855320320] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d964f107-71f6-4ac3-97ec-f6af2a64ff6d; range_end:; response_count:1; response_revision:4863; }","duration":"185.807242ms","start":"2026-08-06T01:11:59.912094Z","end":"2026-08-06T01:12:00.097901Z","steps":["trace[855320320] 'agreement among raft nodes before linearized reading'  (duration: 185.601108ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:12:00.09824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.708619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:7 size:62846"}
{"level":"info","ts":"2026-08-06T01:12:00.098294Z","caller":"traceutil/trace.go:171","msg":"trace[625716480] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:7; response_revision:4863; }","duration":"186.78762ms","start":"2026-08-06T01:11:59.911495Z","end":"2026-08-06T01:12:00.098283Z","steps":["trace[625716480] 'agreement among raft nodes before linearized reading'  (duration: 186.102707ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:12:00.411906Z","caller":"traceutil/trace.go:171","msg":"trace[1220759991] linearizableReadLoop","detail":"{readStateIndex:5064; appliedIndex:5061; }","duration":"172.414727ms","start":"2026-08-06T01:12:00.239474Z","end":"2026-08-06T01:12:00.411889Z","steps":["trace[1220759991] 'read index received'  (duration: 172.182372ms)","trace[1220759991] 'applied index is now lower than readState.Index'  (duration: 231.525µs)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:12:00.411957Z","caller":"traceutil/trace.go:171","msg":"trace[377746639] transaction","detail":"{read_only:false; response_revision:4873; number_of_response:1; }","duration":"195.734309ms","start":"2026-08-06T01:12:00.216191Z","end":"2026-08-06T01:12:00.411926Z","steps":["trace[377746639] 'process raft request'  (duration: 195.617167ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:12:00.411999Z","caller":"traceutil/trace.go:171","msg":"trace[1453408680] transaction","detail":"{read_only:false; response_revision:4872; number_of_response:1; }","duration":"196.400302ms","start":"2026-08-06T01:12:00.215557Z","end":"2026-08-06T01:12:00.411957Z","steps":["trace[1453408680] 'process raft request'  (duration: 196.140277ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:12:00.412059Z","caller":"traceutil/trace.go:171","msg":"trace[1669322726] transaction","detail":"{read_only:false; response_revision:4874; number_of_response:1; }","duration":"194.781222ms","start":"2026-08-06T01:12:00.217243Z","end":"2026-08-06T01:12:00.412024Z","steps":["trace[1669322726] 'process raft request'  (duration: 194.618229ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:12:00.412133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.639601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-08-06T01:12:00.412174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.265606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-nv9sr-tls\" ","response":"range_response_count:1 size:2182"}
{"level":"info","ts":"2026-08-06T01:12:00.412187Z","caller":"traceutil/trace.go:171","msg":"trace[1054036637] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4874; }","duration":"172.719793ms","start":"2026-08-06T01:12:00.239453Z","end":"2026-08-06T01:12:00.412173Z","steps":["trace[1054036637] 'agreement among raft nodes before linearized reading'  (duration: 172.53331ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:12:00.412216Z","caller":"traceutil/trace.go:171","msg":"trace[1132731519] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-nv9sr-tls; range_end:; response_count:1; response_revision:4874; }","duration":"150.354018ms","start":"2026-08-06T01:12:00.261848Z","end":"2026-08-06T01:12:00.412202Z","steps":["trace[1132731519] 'agreement among raft nodes before linearized reading'  (duration: 150.216105ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:12:00.412216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.73128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-08-06T01:12:00.412249Z","caller":"traceutil/trace.go:171","msg":"trace[434967884] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4874; }","duration":"125.807441ms","start":"2026-08-06T01:12:00.28643Z","end":"2026-08-06T01:12:00.412238Z","steps":["trace[434967884] 'agreement among raft nodes before linearized reading'  (duration: 125.713769ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:12:10.159936Z","caller":"traceutil/trace.go:171","msg":"trace[939934896] transaction","detail":"{read_only:false; response_revision:5078; number_of_response:1; }","duration":"119.262986ms","start":"2026-08-06T01:12:10.040648Z","end":"2026-08-06T01:12:10.159911Z","steps":["trace[939934896] 'process raft request'  (duration: 119.106724ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:12:13.276055Z","caller":"traceutil/trace.go:171","msg":"trace[1272383568] linearizableReadLoop","detail":"{readStateIndex:5334; appliedIndex:5333; }","duration":"226.508145ms","start":"2026-08-06T01:12:13.049528Z","end":"2026-08-06T01:12:13.276036Z","steps":["trace[1272383568] 'read index received'  (duration: 226.362612ms)","trace[1272383568] 'applied index is now lower than readState.Index'  (duration: 144.603µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-06T01:12:13.276339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.79011ms","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-08-06T01:12:13.276421Z","caller":"traceutil/trace.go:171","msg":"trace[661128213] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5137; }","duration":"226.946163ms","start":"2026-08-06T01:12:13.049458Z","end":"2026-08-06T01:12:13.276404Z","steps":["trace[661128213] 'agreement among raft nodes before linearized reading'  (duration: 226.690548ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:12:13.276773Z","caller":"traceutil/trace.go:171","msg":"trace[316534782] transaction","detail":"{read_only:false; response_revision:5137; number_of_response:1; }","duration":"264.031557ms","start":"2026-08-06T01:12:13.012067Z","end":"2026-08-06T01:12:13.276098Z","steps":["trace[316534782] 'process raft request'  (duration: 263.828404ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:12:13.313275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.938356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-jpr6m\" ","response":"range_response_count:1 size:7816"}
{"level":"info","ts":"2026-08-06T01:12:13.313366Z","caller":"traceutil/trace.go:171","msg":"trace[1179760238] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-jpr6m; range_end:; response_count:1; response_revision:5138; }","duration":"223.079989ms","start":"2026-08-06T01:12:13.090265Z","end":"2026-08-06T01:12:13.313345Z","steps":["trace[1179760238] 'agreement among raft nodes before linearized reading'  (duration: 222.794694ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:12:13.313617Z","caller":"traceutil/trace.go:171","msg":"trace[1929828600] transaction","detail":"{read_only:false; response_revision:5138; number_of_response:1; }","duration":"148.828309ms","start":"2026-08-06T01:12:13.164771Z","end":"2026-08-06T01:12:13.313599Z","steps":["trace[1929828600] 'process raft request'  (duration: 148.161106ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:12:13.313986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.864203ms","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-08-06T01:12:13.314039Z","caller":"traceutil/trace.go:171","msg":"trace[1999139070] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5138; }","duration":"145.932674ms","start":"2026-08-06T01:12:13.168085Z","end":"2026-08-06T01:12:13.314017Z","steps":["trace[1999139070] 'agreement among raft nodes before linearized reading'  (duration: 145.688219ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:12:20.094625Z","caller":"traceutil/trace.go:171","msg":"trace[1174172442] transaction","detail":"{read_only:false; response_revision:5307; number_of_response:1; }","duration":"102.674161ms","start":"2026-08-06T01:12:19.991921Z","end":"2026-08-06T01:12:20.094595Z","steps":["trace[1174172442] 'process raft request'  (duration: 93.216332ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:12:20.385184Z","caller":"traceutil/trace.go:171","msg":"trace[1078849531] transaction","detail":"{read_only:false; response_revision:5309; number_of_response:1; }","duration":"160.575222ms","start":"2026-08-06T01:12:20.224587Z","end":"2026-08-06T01:12:20.385162Z","steps":["trace[1078849531] 'process raft request'  (duration: 139.42365ms)","trace[1078849531] 'compare'  (duration: 21.063591ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:12:20.400526Z","caller":"traceutil/trace.go:171","msg":"trace[388734947] linearizableReadLoop","detail":"{readStateIndex:5511; appliedIndex:5509; }","duration":"169.043972ms","start":"2026-08-06T01:12:20.23146Z","end":"2026-08-06T01:12:20.400504Z","steps":["trace[388734947] 'read index received'  (duration: 132.544549ms)","trace[388734947] 'applied index is now lower than readState.Index'  (duration: 36.498673ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:12:20.400608Z","caller":"traceutil/trace.go:171","msg":"trace[1701022733] transaction","detail":"{read_only:false; response_revision:5310; number_of_response:1; }","duration":"171.342607ms","start":"2026-08-06T01:12:20.229222Z","end":"2026-08-06T01:12:20.400564Z","steps":["trace[1701022733] 'process raft request'  (duration: 171.193344ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:12:20.400721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.250518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e8a45062-5bb0-46f8-8bae-427f5bd53101\" ","response":"range_response_count:1 size:3764"}
{"level":"info","ts":"2026-08-06T01:12:20.40076Z","caller":"traceutil/trace.go:171","msg":"trace[275694649] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e8a45062-5bb0-46f8-8bae-427f5bd53101; range_end:; response_count:1; response_revision:5310; }","duration":"167.311219ms","start":"2026-08-06T01:12:20.233436Z","end":"2026-08-06T01:12:20.400747Z","steps":["trace[275694649] 'agreement among raft nodes before linearized reading'  (duration: 167.177656ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:12:20.40074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.253396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"}
{"level":"info","ts":"2026-08-06T01:12:20.400815Z","caller":"traceutil/trace.go:171","msg":"trace[1129019076] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5310; }","duration":"169.354708ms","start":"2026-08-06T01:12:20.231442Z","end":"2026-08-06T01:12:20.400797Z","steps":["trace[1129019076] 'agreement among raft nodes before linearized reading'  (duration: 169.139864ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:13:10.891998Z","caller":"traceutil/trace.go:171","msg":"trace[1360602532] linearizableReadLoop","detail":"{readStateIndex:5992; appliedIndex:5990; }","duration":"115.625399ms","start":"2026-08-06T01:13:10.776343Z","end":"2026-08-06T01:13:10.891968Z","steps":["trace[1360602532] 'read index received'  (duration: 2.332894ms)","trace[1360602532] 'applied index is now lower than readState.Index'  (duration: 113.291065ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:13:10.892117Z","caller":"traceutil/trace.go:171","msg":"trace[1742072542] transaction","detail":"{read_only:false; response_revision:5779; number_of_response:1; }","duration":"117.977824ms","start":"2026-08-06T01:13:10.774104Z","end":"2026-08-06T01:13:10.892082Z","steps":["trace[1742072542] 'process raft request'  (duration: 102.816146ms)","trace[1742072542] 'compare'  (duration: 14.880183ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-06T01:13:10.892209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.845174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-06T01:13:10.892408Z","caller":"traceutil/trace.go:171","msg":"trace[615706635] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5779; }","duration":"116.090168ms","start":"2026-08-06T01:13:10.776276Z","end":"2026-08-06T01:13:10.892366Z","steps":["trace[615706635] 'agreement among raft nodes before linearized reading'  (duration: 115.828923ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:13:56.06741Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2967}
{"level":"info","ts":"2026-08-06T01:13:56.139522Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2967,"took":"70.076862ms","hash":1010889456,"current-db-size-bytes":59424768,"current-db-size":"59 MB","current-db-size-in-use-bytes":34418688,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-08-06T01:13:56.139578Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1010889456,"revision":2967,"compact-revision":-1}
{"level":"info","ts":"2026-08-06T01:18:24.233764Z","caller":"traceutil/trace.go:171","msg":"trace[2144782223] transaction","detail":"{read_only:false; response_revision:8103; number_of_response:1; }","duration":"112.362501ms","start":"2026-08-06T01:18:24.12137Z","end":"2026-08-06T01:18:24.233732Z","steps":["trace[2144782223] 'process raft request'  (duration: 112.141347ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:18:24.366545Z","caller":"traceutil/trace.go:171","msg":"trace[2035204873] linearizableReadLoop","detail":"{readStateIndex:8391; appliedIndex:8389; }","duration":"165.799573ms","start":"2026-08-06T01:18:24.200717Z","end":"2026-08-06T01:18:24.366516Z","steps":["trace[2035204873] 'read index received'  (duration: 32.863198ms)","trace[2035204873] 'applied index is now lower than readState.Index'  (duration: 132.934935ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-06T01:18:24.366837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.098249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-sznhj\" ","response":"range_response_count:1 size:6523"}
{"level":"info","ts":"2026-08-06T01:18:24.36688Z","caller":"traceutil/trace.go:171","msg":"trace[1661401061] range","detail":"{range_begin:/registry/pods/openstack/keepalived-sznhj; range_end:; response_count:1; response_revision:8103; }","duration":"166.19828ms","start":"2026-08-06T01:18:24.200669Z","end":"2026-08-06T01:18:24.366867Z","steps":["trace[1661401061] 'agreement among raft nodes before linearized reading'  (duration: 165.993416ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:18:24.367075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.428017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-08-06T01:18:24.367139Z","caller":"traceutil/trace.go:171","msg":"trace[2091732852] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8103; }","duration":"163.55868ms","start":"2026-08-06T01:18:24.203566Z","end":"2026-08-06T01:18:24.367125Z","steps":["trace[2091732852] 'agreement among raft nodes before linearized reading'  (duration: 163.168503ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:18:56.07484Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6129}
{"level":"info","ts":"2026-08-06T01:18:56.174391Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6129,"took":"97.663239ms","hash":4126143556,"current-db-size-bytes":59424768,"current-db-size":"59 MB","current-db-size-in-use-bytes":23052288,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-08-06T01:18:56.174463Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4126143556,"revision":6129,"compact-revision":2967}
{"level":"info","ts":"2026-08-06T01:19:04.924462Z","caller":"traceutil/trace.go:171","msg":"trace[1806918734] linearizableReadLoop","detail":"{readStateIndex:8674; appliedIndex:8673; }","duration":"331.794811ms","start":"2026-08-06T01:19:04.592637Z","end":"2026-08-06T01:19:04.924431Z","steps":["trace[1806918734] 'read index received'  (duration: 331.617288ms)","trace[1806918734] 'applied index is now lower than readState.Index'  (duration: 176.123µs)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:19:04.924496Z","caller":"traceutil/trace.go:171","msg":"trace[1157499843] transaction","detail":"{read_only:false; response_revision:8374; number_of_response:1; }","duration":"354.460045ms","start":"2026-08-06T01:19:04.570009Z","end":"2026-08-06T01:19:04.924469Z","steps":["trace[1157499843] 'process raft request'  (duration: 354.22319ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:19:04.924686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:19:04.569994Z","time spent":"354.568167ms","remote":"127.0.0.1:52024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:8364 > 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":"warn","ts":"2026-08-06T01:19:04.924878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.173568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-sznhj\" ","response":"range_response_count:1 size:6523"}
{"level":"info","ts":"2026-08-06T01:19:04.924969Z","caller":"traceutil/trace.go:171","msg":"trace[294521394] range","detail":"{range_begin:/registry/pods/openstack/keepalived-sznhj; range_end:; response_count:1; response_revision:8374; }","duration":"332.337371ms","start":"2026-08-06T01:19:04.592612Z","end":"2026-08-06T01:19:04.92495Z","steps":["trace[294521394] 'agreement among raft nodes before linearized reading'  (duration: 331.943774ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:19:04.925017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:19:04.592602Z","time spent":"332.404982ms","remote":"127.0.0.1:51926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6546,"request content":"key:\"/registry/pods/openstack/keepalived-sznhj\" "}
{"level":"info","ts":"2026-08-06T01:19:05.120715Z","caller":"traceutil/trace.go:171","msg":"trace[917212042] transaction","detail":"{read_only:false; response_revision:8375; number_of_response:1; }","duration":"473.410561ms","start":"2026-08-06T01:19:04.647261Z","end":"2026-08-06T01:19:05.120672Z","steps":["trace[917212042] 'process raft request'  (duration: 472.987793ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:19:05.120861Z","caller":"traceutil/trace.go:171","msg":"trace[1723226741] linearizableReadLoop","detail":"{readStateIndex:8676; appliedIndex:8674; }","duration":"196.276257ms","start":"2026-08-06T01:19:04.924543Z","end":"2026-08-06T01:19:05.120819Z","steps":["trace[1723226741] 'read index received'  (duration: 195.598714ms)","trace[1723226741] 'applied index is now lower than readState.Index'  (duration: 675.763µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-06T01:19:05.12094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:19:04.647241Z","time spent":"473.566954ms","remote":"127.0.0.1:45528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":414529,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" mod_revision:7823 > success:<request_put:<key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" value_size:414461 >> failure:<request_range:<key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" > >"}
{"level":"info","ts":"2026-08-06T01:19:05.120981Z","caller":"traceutil/trace.go:171","msg":"trace[982748933] transaction","detail":"{read_only:false; response_revision:8376; number_of_response:1; }","duration":"198.161173ms","start":"2026-08-06T01:19:04.922809Z","end":"2026-08-06T01:19:05.120971Z","steps":["trace[982748933] 'process raft request'  (duration: 197.768135ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:19:05.121194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.689104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-08-06T01:19:05.121237Z","caller":"traceutil/trace.go:171","msg":"trace[1641490506] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8376; }","duration":"464.766925ms","start":"2026-08-06T01:19:04.656457Z","end":"2026-08-06T01:19:05.121224Z","steps":["trace[1641490506] 'agreement among raft nodes before linearized reading'  (duration: 464.629963ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:19:05.121267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:19:04.656445Z","time spent":"464.814646ms","remote":"127.0.0.1:52024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-08-06T01:19:05.121467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.056184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-08-06T01:19:05.1215Z","caller":"traceutil/trace.go:171","msg":"trace[599573129] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8376; }","duration":"496.106975ms","start":"2026-08-06T01:19:04.625385Z","end":"2026-08-06T01:19:05.121492Z","steps":["trace[599573129] 'agreement among raft nodes before linearized reading'  (duration: 496.020114ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:19:05.121526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:19:04.625373Z","time spent":"496.147506ms","remote":"127.0.0.1:52024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-08-06T01:19:05.121602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.426933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228463"}
{"level":"info","ts":"2026-08-06T01:19:05.121675Z","caller":"traceutil/trace.go:171","msg":"trace[311197154] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8376; }","duration":"192.508855ms","start":"2026-08-06T01:19:04.929146Z","end":"2026-08-06T01:19:05.121655Z","steps":["trace[311197154] 'agreement among raft nodes before linearized reading'  (duration: 192.100667ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:19:17.7886Z","caller":"traceutil/trace.go:171","msg":"trace[1703900816] linearizableReadLoop","detail":"{readStateIndex:8788; appliedIndex:8787; }","duration":"279.87826ms","start":"2026-08-06T01:19:17.508698Z","end":"2026-08-06T01:19:17.788576Z","steps":["trace[1703900816] 'read index received'  (duration: 279.769068ms)","trace[1703900816] 'applied index is now lower than readState.Index'  (duration: 108.102µs)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:19:17.788646Z","caller":"traceutil/trace.go:171","msg":"trace[691154406] transaction","detail":"{read_only:false; response_revision:8483; number_of_response:1; }","duration":"280.318418ms","start":"2026-08-06T01:19:17.508294Z","end":"2026-08-06T01:19:17.788612Z","steps":["trace[691154406] 'process raft request'  (duration: 280.118954ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:19:17.788839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.128964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-2h4d7\" ","response":"range_response_count:1 size:2800"}
{"level":"info","ts":"2026-08-06T01:19:17.788886Z","caller":"traceutil/trace.go:171","msg":"trace[1724215596] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-2h4d7; range_end:; response_count:1; response_revision:8483; }","duration":"280.228597ms","start":"2026-08-06T01:19:17.50864Z","end":"2026-08-06T01:19:17.788869Z","steps":["trace[1724215596] 'agreement among raft nodes before linearized reading'  (duration: 280.053883ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:19:17.872368Z","caller":"traceutil/trace.go:171","msg":"trace[297333984] transaction","detail":"{read_only:false; response_revision:8484; number_of_response:1; }","duration":"318.504734ms","start":"2026-08-06T01:19:17.553839Z","end":"2026-08-06T01:19:17.872344Z","steps":["trace[297333984] 'process raft request'  (duration: 311.55687ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:19:17.872524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:19:17.553802Z","time spent":"318.640736ms","remote":"127.0.0.1:52024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8464 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-08-06T01:19:17.872909Z","caller":"traceutil/trace.go:171","msg":"trace[977688010] transaction","detail":"{read_only:false; response_revision:8486; number_of_response:1; }","duration":"288.149739ms","start":"2026-08-06T01:19:17.584718Z","end":"2026-08-06T01:19:17.872868Z","steps":["trace[977688010] 'process raft request'  (duration: 287.940775ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:19:17.872997Z","caller":"traceutil/trace.go:171","msg":"trace[2013961126] transaction","detail":"{read_only:false; response_revision:8485; number_of_response:1; }","duration":"307.223727ms","start":"2026-08-06T01:19:17.565738Z","end":"2026-08-06T01:19:17.872962Z","steps":["trace[2013961126] 'process raft request'  (duration: 306.572194ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:19:17.873042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.671873ms","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-08-06T01:19:17.873142Z","caller":"traceutil/trace.go:171","msg":"trace[1350650045] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8486; }","duration":"229.833086ms","start":"2026-08-06T01:19:17.643297Z","end":"2026-08-06T01:19:17.87313Z","steps":["trace[1350650045] 'agreement among raft nodes before linearized reading'  (duration: 229.599512ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:19:17.873169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:19:17.565724Z","time spent":"307.355489ms","remote":"127.0.0.1:52024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8465 > 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-08-06T01:19:17.873182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.005253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-08-06T01:19:17.873223Z","caller":"traceutil/trace.go:171","msg":"trace[1377544423] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8486; }","duration":"225.072764ms","start":"2026-08-06T01:19:17.648141Z","end":"2026-08-06T01:19:17.873214Z","steps":["trace[1377544423] 'agreement among raft nodes before linearized reading'  (duration: 224.744997ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:19:17.873262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.675848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-2h4d7\" ","response":"range_response_count:1 size:4646"}
{"level":"info","ts":"2026-08-06T01:19:17.873339Z","caller":"traceutil/trace.go:171","msg":"trace[1318404994] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-2h4d7; range_end:; response_count:1; response_revision:8486; }","duration":"289.809031ms","start":"2026-08-06T01:19:17.583512Z","end":"2026-08-06T01:19:17.873321Z","steps":["trace[1318404994] 'agreement among raft nodes before linearized reading'  (duration: 289.546116ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:19:18.587823Z","caller":"traceutil/trace.go:171","msg":"trace[1365890313] transaction","detail":"{read_only:false; response_revision:8491; number_of_response:1; }","duration":"109.985738ms","start":"2026-08-06T01:19:18.477802Z","end":"2026-08-06T01:19:18.587788Z","steps":["trace[1365890313] 'process raft request'  (duration: 109.741273ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:19:19.341953Z","caller":"traceutil/trace.go:171","msg":"trace[1521971152] linearizableReadLoop","detail":"{readStateIndex:8805; appliedIndex:8804; }","duration":"121.777015ms","start":"2026-08-06T01:19:19.220158Z","end":"2026-08-06T01:19:19.341935Z","steps":["trace[1521971152] 'read index received'  (duration: 8.79767ms)","trace[1521971152] 'applied index is now lower than readState.Index'  (duration: 112.978545ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-06T01:19:19.342246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.07269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228378"}
{"level":"info","ts":"2026-08-06T01:19:19.34227Z","caller":"traceutil/trace.go:171","msg":"trace[1543534346] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8499; }","duration":"122.134541ms","start":"2026-08-06T01:19:19.22013Z","end":"2026-08-06T01:19:19.342265Z","steps":["trace[1543534346] 'agreement among raft nodes before linearized reading'  (duration: 121.874496ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:19:19.342425Z","caller":"traceutil/trace.go:171","msg":"trace[775309948] transaction","detail":"{read_only:false; response_revision:8499; number_of_response:1; }","duration":"122.293015ms","start":"2026-08-06T01:19:19.220126Z","end":"2026-08-06T01:19:19.342419Z","steps":["trace[775309948] 'process raft request'  (duration: 89.233928ms)","trace[775309948] 'compare'  (duration: 32.446315ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:20:04.697011Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002406.wal"}
{"level":"info","ts":"2026-08-06T01:21:32.530159Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"dcb0af7a3afe1d6d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-06T01:21:32.536291Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-08-06T01:21:32.536422Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-08-06T01:23:56.081171Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8278}
{"level":"info","ts":"2026-08-06T01:23:56.162717Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8278,"took":"78.896747ms","hash":3371715900,"current-db-size-bytes":59424768,"current-db-size":"59 MB","current-db-size-in-use-bytes":26669056,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-08-06T01:23:56.162796Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3371715900,"revision":8278,"compact-revision":6129}
{"level":"warn","ts":"2026-08-06T01:24:17.312589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.890556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-06T01:24:17.31272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.858026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-06T01:24:17.312799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.588877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-06T01:24:17.312767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.13188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-06T01:24:17.312778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.348051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-06T01:24:17.312868Z","caller":"traceutil/trace.go:171","msg":"trace[666206668] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:11086; }","duration":"114.259813ms","start":"2026-08-06T01:24:17.198588Z","end":"2026-08-06T01:24:17.312848Z","steps":["trace[666206668] 'range keys from in-memory index tree'  (duration: 113.989198ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:24:17.312882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.508806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-06T01:24:17.312919Z","caller":"traceutil/trace.go:171","msg":"trace[1699890250] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:11086; }","duration":"116.597148ms","start":"2026-08-06T01:24:17.196311Z","end":"2026-08-06T01:24:17.312909Z","steps":["trace[1699890250] 'range keys from in-memory index tree'  (duration: 116.017217ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:24:17.312936Z","caller":"traceutil/trace.go:171","msg":"trace[1645236863] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:11086; }","duration":"106.592416ms","start":"2026-08-06T01:24:17.206307Z","end":"2026-08-06T01:24:17.312899Z","steps":["trace[1645236863] 'range keys from in-memory index tree'  (duration: 106.187229ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:24:17.312958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.816883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-06T01:24:17.312744Z","caller":"traceutil/trace.go:171","msg":"trace[1371274680] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:11086; }","duration":"114.077149ms","start":"2026-08-06T01:24:17.198637Z","end":"2026-08-06T01:24:17.312715Z","steps":["trace[1371274680] 'range keys from in-memory index tree'  (duration: 113.832474ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:24:17.313012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.964867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/cinder-api\" ","response":"range_response_count:1 size:667"}
{"level":"info","ts":"2026-08-06T01:24:17.313049Z","caller":"traceutil/trace.go:171","msg":"trace[1237231028] range","detail":"{range_begin:/registry/services/endpoints/openstack/cinder-api; range_end:; response_count:1; response_revision:11086; }","duration":"114.022848ms","start":"2026-08-06T01:24:17.199017Z","end":"2026-08-06T01:24:17.31304Z","steps":["trace[1237231028] 'range keys from in-memory index tree'  (duration: 113.835785ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:24:17.312731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.492269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5079"}
{"level":"info","ts":"2026-08-06T01:24:17.312842Z","caller":"traceutil/trace.go:171","msg":"trace[1273521585] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:11086; }","duration":"116.695069ms","start":"2026-08-06T01:24:17.196137Z","end":"2026-08-06T01:24:17.312832Z","steps":["trace[1273521585] 'range keys from in-memory index tree'  (duration: 115.949015ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:24:17.313078Z","caller":"traceutil/trace.go:171","msg":"trace[383110407] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:11086; }","duration":"115.946895ms","start":"2026-08-06T01:24:17.197106Z","end":"2026-08-06T01:24:17.313053Z","steps":["trace[383110407] 'range keys from in-memory index tree'  (duration: 114.952776ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:24:17.312628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.620518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-06T01:24:17.313172Z","caller":"traceutil/trace.go:171","msg":"trace[480210855] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:11086; }","duration":"117.26445ms","start":"2026-08-06T01:24:17.195896Z","end":"2026-08-06T01:24:17.31316Z","steps":["trace[480210855] 'range keys from in-memory index tree'  (duration: 116.442154ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:24:17.312842Z","caller":"traceutil/trace.go:171","msg":"trace[1781239909] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:11086; }","duration":"113.979888ms","start":"2026-08-06T01:24:17.198813Z","end":"2026-08-06T01:24:17.312793Z","steps":["trace[1781239909] 'range keys from in-memory index tree'  (duration: 113.788254ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:24:17.313155Z","caller":"traceutil/trace.go:171","msg":"trace[759350421] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:11086; }","duration":"113.939337ms","start":"2026-08-06T01:24:17.199192Z","end":"2026-08-06T01:24:17.313131Z","steps":["trace[759350421] 'range keys from in-memory index tree'  (duration: 113.373416ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:28:56.088033Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10965}
{"level":"info","ts":"2026-08-06T01:28:56.171332Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10965,"took":"80.884238ms","hash":3047479434,"current-db-size-bytes":59424768,"current-db-size":"59 MB","current-db-size-in-use-bytes":28274688,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-08-06T01:28:56.171391Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3047479434,"revision":10965,"compact-revision":8278}
{"level":"info","ts":"2026-08-06T01:31:08.591177Z","caller":"traceutil/trace.go:171","msg":"trace[359009981] transaction","detail":"{read_only:false; response_revision:14003; number_of_response:1; }","duration":"119.110928ms","start":"2026-08-06T01:31:08.472034Z","end":"2026-08-06T01:31:08.591144Z","steps":["trace[359009981] 'process raft request'  (duration: 118.919025ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:31:08.885654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.777003ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2120526735012891318 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:13934 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-06T01:31:08.885885Z","caller":"traceutil/trace.go:171","msg":"trace[286900869] transaction","detail":"{read_only:false; response_revision:14004; number_of_response:1; }","duration":"360.089111ms","start":"2026-08-06T01:31:08.525759Z","end":"2026-08-06T01:31:08.885848Z","steps":["trace[286900869] 'process raft request'  (duration: 160.966761ms)","trace[286900869] 'compare'  (duration: 198.189512ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:31:08.885974Z","caller":"traceutil/trace.go:171","msg":"trace[1717022270] linearizableReadLoop","detail":"{readStateIndex:14488; appliedIndex:14486; }","duration":"254.617713ms","start":"2026-08-06T01:31:08.631331Z","end":"2026-08-06T01:31:08.885949Z","steps":["trace[1717022270] 'read index received'  (duration: 55.458072ms)","trace[1717022270] 'applied index is now lower than readState.Index'  (duration: 199.158061ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:31:08.886034Z","caller":"traceutil/trace.go:171","msg":"trace[106500825] transaction","detail":"{read_only:false; response_revision:14005; number_of_response:1; }","duration":"360.090092ms","start":"2026-08-06T01:31:08.52591Z","end":"2026-08-06T01:31:08.886Z","steps":["trace[106500825] 'process raft request'  (duration: 359.895208ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:31:08.886066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:31:08.525729Z","time spent":"360.233314ms","remote":"127.0.0.1:52024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:13934 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-08-06T01:31:08.886192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:31:08.525902Z","time spent":"360.209684ms","remote":"127.0.0.1:52024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:13935 > 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-08-06T01:31:08.886241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.899318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a6e816e1-adbe-48ea-93c6-1c07abbef2cf\" ","response":"range_response_count:1 size:3635"}
{"level":"info","ts":"2026-08-06T01:31:08.886288Z","caller":"traceutil/trace.go:171","msg":"trace[860666191] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a6e816e1-adbe-48ea-93c6-1c07abbef2cf; range_end:; response_count:1; response_revision:14005; }","duration":"254.99436ms","start":"2026-08-06T01:31:08.63128Z","end":"2026-08-06T01:31:08.886275Z","steps":["trace[860666191] 'agreement among raft nodes before linearized reading'  (duration: 254.801957ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:31:08.886484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.45064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-sznhj\" ","response":"range_response_count:1 size:6523"}
{"level":"info","ts":"2026-08-06T01:31:08.886543Z","caller":"traceutil/trace.go:171","msg":"trace[1487033289] range","detail":"{range_begin:/registry/pods/openstack/keepalived-sznhj; range_end:; response_count:1; response_revision:14005; }","duration":"254.549552ms","start":"2026-08-06T01:31:08.631976Z","end":"2026-08-06T01:31:08.886525Z","steps":["trace[1487033289] 'agreement among raft nodes before linearized reading'  (duration: 254.144384ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:31:08.886518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.000886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a6e816e1-adbe-48ea-93c6-1c07abbef2cf\" ","response":"range_response_count:1 size:3635"}
{"level":"info","ts":"2026-08-06T01:31:08.886624Z","caller":"traceutil/trace.go:171","msg":"trace[1796432144] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a6e816e1-adbe-48ea-93c6-1c07abbef2cf; range_end:; response_count:1; response_revision:14005; }","duration":"133.118238ms","start":"2026-08-06T01:31:08.753484Z","end":"2026-08-06T01:31:08.886602Z","steps":["trace[1796432144] 'agreement among raft nodes before linearized reading'  (duration: 132.795292ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:32:40.88834Z","caller":"traceutil/trace.go:171","msg":"trace[1798234530] linearizableReadLoop","detail":"{readStateIndex:15360; appliedIndex:15359; }","duration":"194.176743ms","start":"2026-08-06T01:32:40.694091Z","end":"2026-08-06T01:32:40.888267Z","steps":["trace[1798234530] 'read index received'  (duration: 193.857107ms)","trace[1798234530] 'applied index is now lower than readState.Index'  (duration: 317.525µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-06T01:32:40.888638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.926965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-06T01:32:40.888706Z","caller":"traceutil/trace.go:171","msg":"trace[498806157] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:14853; }","duration":"117.035937ms","start":"2026-08-06T01:32:40.77165Z","end":"2026-08-06T01:32:40.888686Z","steps":["trace[498806157] 'agreement among raft nodes before linearized reading'  (duration: 116.880974ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:32:40.888681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.562369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-8dbs8\" ","response":"range_response_count:1 size:20652"}
{"level":"info","ts":"2026-08-06T01:32:40.888609Z","caller":"traceutil/trace.go:171","msg":"trace[113989813] transaction","detail":"{read_only:false; response_revision:14853; number_of_response:1; }","duration":"224.061043ms","start":"2026-08-06T01:32:40.664371Z","end":"2026-08-06T01:32:40.888432Z","steps":["trace[113989813] 'process raft request'  (duration: 223.625334ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:32:40.888784Z","caller":"traceutil/trace.go:171","msg":"trace[1676160756] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-8dbs8; range_end:; response_count:1; response_revision:14853; }","duration":"194.685472ms","start":"2026-08-06T01:32:40.694076Z","end":"2026-08-06T01:32:40.888761Z","steps":["trace[1676160756] 'agreement among raft nodes before linearized reading'  (duration: 194.376356ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:33:56.092848Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13009}
{"level":"info","ts":"2026-08-06T01:33:56.172636Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13009,"took":"76.712627ms","hash":2651795605,"current-db-size-bytes":59424768,"current-db-size":"59 MB","current-db-size-in-use-bytes":30625792,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-08-06T01:33:56.172691Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2651795605,"revision":13009,"compact-revision":10965}
{"level":"info","ts":"2026-08-06T01:38:17.884692Z","caller":"traceutil/trace.go:171","msg":"trace[991995231] linearizableReadLoop","detail":"{readStateIndex:17970; appliedIndex:17969; }","duration":"239.745639ms","start":"2026-08-06T01:38:17.64492Z","end":"2026-08-06T01:38:17.884665Z","steps":["trace[991995231] 'read index received'  (duration: 239.577016ms)","trace[991995231] 'applied index is now lower than readState.Index'  (duration: 167.803µs)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:38:17.8848Z","caller":"traceutil/trace.go:171","msg":"trace[858514288] transaction","detail":"{read_only:false; response_revision:17382; number_of_response:1; }","duration":"240.291849ms","start":"2026-08-06T01:38:17.644478Z","end":"2026-08-06T01:38:17.88477Z","steps":["trace[858514288] 'process raft request'  (duration: 240.047164ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:38:17.884899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.971423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1782"}
{"level":"info","ts":"2026-08-06T01:38:17.88493Z","caller":"traceutil/trace.go:171","msg":"trace[2091170253] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:17382; }","duration":"240.055165ms","start":"2026-08-06T01:38:17.644863Z","end":"2026-08-06T01:38:17.884918Z","steps":["trace[2091170253] 'agreement among raft nodes before linearized reading'  (duration: 239.898102ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:38:18.394195Z","caller":"traceutil/trace.go:171","msg":"trace[1026266867] linearizableReadLoop","detail":"{readStateIndex:17971; appliedIndex:17970; }","duration":"219.37041ms","start":"2026-08-06T01:38:18.174802Z","end":"2026-08-06T01:38:18.394172Z","steps":["trace[1026266867] 'read index received'  (duration: 219.228537ms)","trace[1026266867] 'applied index is now lower than readState.Index'  (duration: 140.813µs)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:38:18.394228Z","caller":"traceutil/trace.go:171","msg":"trace[1659927485] transaction","detail":"{read_only:false; response_revision:17383; number_of_response:1; }","duration":"225.891685ms","start":"2026-08-06T01:38:18.168313Z","end":"2026-08-06T01:38:18.394204Z","steps":["trace[1659927485] 'process raft request'  (duration: 225.717771ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:38:18.394362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.582844ms","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-08-06T01:38:18.394398Z","caller":"traceutil/trace.go:171","msg":"trace[1650896314] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:17383; }","duration":"219.694416ms","start":"2026-08-06T01:38:18.174692Z","end":"2026-08-06T01:38:18.394387Z","steps":["trace[1650896314] 'agreement among raft nodes before linearized reading'  (duration: 219.565654ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:38:26.834924Z","caller":"traceutil/trace.go:171","msg":"trace[715664626] linearizableReadLoop","detail":"{readStateIndex:18095; appliedIndex:18093; }","duration":"124.035119ms","start":"2026-08-06T01:38:26.710864Z","end":"2026-08-06T01:38:26.834899Z","steps":["trace[715664626] 'read index received'  (duration: 4.532667ms)","trace[715664626] 'applied index is now lower than readState.Index'  (duration: 119.501442ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:38:26.835363Z","caller":"traceutil/trace.go:171","msg":"trace[1739727588] transaction","detail":"{read_only:false; response_revision:17505; number_of_response:1; }","duration":"124.545058ms","start":"2026-08-06T01:38:26.710777Z","end":"2026-08-06T01:38:26.835322Z","steps":["trace[1739727588] 'process raft request'  (duration: 104.886253ms)","trace[1739727588] 'compare'  (duration: 19.013383ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:38:26.835403Z","caller":"traceutil/trace.go:171","msg":"trace[275295608] transaction","detail":"{read_only:false; response_revision:17506; number_of_response:1; }","duration":"121.363747ms","start":"2026-08-06T01:38:26.714024Z","end":"2026-08-06T01:38:26.835388Z","steps":["trace[275295608] 'process raft request'  (duration: 120.799797ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:38:26.835571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.686341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/openstack/libvirt-libvirt-default-8dbs8-vnc\" ","response":"range_response_count:1 size:910"}
{"level":"info","ts":"2026-08-06T01:38:26.835615Z","caller":"traceutil/trace.go:171","msg":"trace[412110169] range","detail":"{range_begin:/registry/cert-manager.io/certificates/openstack/libvirt-libvirt-default-8dbs8-vnc; range_end:; response_count:1; response_revision:17506; }","duration":"124.758752ms","start":"2026-08-06T01:38:26.710841Z","end":"2026-08-06T01:38:26.8356Z","steps":["trace[412110169] 'agreement among raft nodes before linearized reading'  (duration: 124.591699ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:38:26.839205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.154309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/openstack/libvirt-libvirt-default-8dbs8-api\" ","response":"range_response_count:1 size:1499"}
{"level":"info","ts":"2026-08-06T01:38:26.839289Z","caller":"traceutil/trace.go:171","msg":"trace[114975047] range","detail":"{range_begin:/registry/cert-manager.io/certificates/openstack/libvirt-libvirt-default-8dbs8-api; range_end:; response_count:1; response_revision:17507; }","duration":"126.258311ms","start":"2026-08-06T01:38:26.713014Z","end":"2026-08-06T01:38:26.839272Z","steps":["trace[114975047] 'agreement among raft nodes before linearized reading'  (duration: 126.105388ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:38:26.839494Z","caller":"traceutil/trace.go:171","msg":"trace[1798968162] transaction","detail":"{read_only:false; number_of_response:1; response_revision:17506; }","duration":"122.155583ms","start":"2026-08-06T01:38:26.717327Z","end":"2026-08-06T01:38:26.839482Z","steps":["trace[1798968162] 'process raft request'  (duration: 121.629732ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:38:26.839736Z","caller":"traceutil/trace.go:171","msg":"trace[104167729] transaction","detail":"{read_only:false; response_revision:17507; number_of_response:1; }","duration":"121.575582ms","start":"2026-08-06T01:38:26.718147Z","end":"2026-08-06T01:38:26.839723Z","steps":["trace[104167729] 'process raft request'  (duration: 120.871108ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:38:26.839871Z","caller":"traceutil/trace.go:171","msg":"trace[1065976744] transaction","detail":"{read_only:false; number_of_response:1; response_revision:17507; }","duration":"120.547032ms","start":"2026-08-06T01:38:26.719314Z","end":"2026-08-06T01:38:26.839861Z","steps":["trace[1065976744] 'process raft request'  (duration: 119.776066ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:38:56.10461Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15360}
{"level":"info","ts":"2026-08-06T01:38:56.208529Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15360,"took":"99.445418ms","hash":243410304,"current-db-size-bytes":59424768,"current-db-size":"59 MB","current-db-size-in-use-bytes":32153600,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-06T01:38:56.208643Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":243410304,"revision":15360,"compact-revision":13009}
{"level":"info","ts":"2026-08-06T01:42:19.105572Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"dcb0af7a3afe1d6d","local-member-applied-index":20003,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-06T01:42:19.115908Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20003}
{"level":"info","ts":"2026-08-06T01:42:19.116012Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15003}
{"level":"info","ts":"2026-08-06T01:43:56.111052Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17755}
{"level":"info","ts":"2026-08-06T01:43:56.222413Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17755,"took":"107.430539ms","hash":3705837115,"current-db-size-bytes":59424768,"current-db-size":"59 MB","current-db-size-in-use-bytes":33406976,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-08-06T01:43:56.222497Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3705837115,"revision":17755,"compact-revision":15360}
{"level":"info","ts":"2026-08-06T01:44:02.416287Z","caller":"traceutil/trace.go:171","msg":"trace[147146755] transaction","detail":"{read_only:false; response_revision:20053; number_of_response:1; }","duration":"107.917318ms","start":"2026-08-06T01:44:02.308336Z","end":"2026-08-06T01:44:02.416254Z","steps":["trace[147146755] 'process raft request'  (duration: 107.294016ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:44:02.502529Z","caller":"traceutil/trace.go:171","msg":"trace[1754396377] transaction","detail":"{read_only:false; response_revision:20054; number_of_response:1; }","duration":"193.904939ms","start":"2026-08-06T01:44:02.308594Z","end":"2026-08-06T01:44:02.502499Z","steps":["trace[1754396377] 'process raft request'  (duration: 193.761726ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:44:02.701922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.124241ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2120526735012912188 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:20000 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-06T01:44:02.702015Z","caller":"traceutil/trace.go:171","msg":"trace[842302689] linearizableReadLoop","detail":"{readStateIndex:20735; appliedIndex:20734; }","duration":"109.306965ms","start":"2026-08-06T01:44:02.592693Z","end":"2026-08-06T01:44:02.702Z","steps":["trace[842302689] 'read index received'  (duration: 59.901µs)","trace[842302689] 'applied index is now lower than readState.Index'  (duration: 109.246174ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-06T01:44:02.702168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.486189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0\" ","response":"range_response_count:1 size:1850"}
{"level":"info","ts":"2026-08-06T01:44:02.702209Z","caller":"traceutil/trace.go:171","msg":"trace[382155767] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0; range_end:; response_count:1; response_revision:20055; }","duration":"109.569711ms","start":"2026-08-06T01:44:02.592624Z","end":"2026-08-06T01:44:02.702193Z","steps":["trace[382155767] 'agreement among raft nodes before linearized reading'  (duration: 109.451989ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:44:02.702188Z","caller":"traceutil/trace.go:171","msg":"trace[1395523625] transaction","detail":"{read_only:false; response_revision:20055; number_of_response:1; }","duration":"276.963195ms","start":"2026-08-06T01:44:02.425176Z","end":"2026-08-06T01:44:02.702139Z","steps":["trace[1395523625] 'process raft request'  (duration: 154.536579ms)","trace[1395523625] 'compare'  (duration: 121.944497ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:44:02.849299Z","caller":"traceutil/trace.go:171","msg":"trace[1167715103] transaction","detail":"{read_only:false; response_revision:20057; number_of_response:1; }","duration":"141.559361ms","start":"2026-08-06T01:44:02.707691Z","end":"2026-08-06T01:44:02.849251Z","steps":["trace[1167715103] 'process raft request'  (duration: 137.88755ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-06T01:47:42.996584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.72232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:697"}
{"level":"info","ts":"2026-08-06T01:47:42.996698Z","caller":"traceutil/trace.go:171","msg":"trace[1216625903] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:22294; }","duration":"134.876063ms","start":"2026-08-06T01:47:42.861796Z","end":"2026-08-06T01:47:42.996672Z","steps":["trace[1216625903] 'range keys from in-memory index tree'  (duration: 134.540697ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:47:49.356266Z","caller":"traceutil/trace.go:171","msg":"trace[1488111361] linearizableReadLoop","detail":"{readStateIndex:23204; appliedIndex:23203; }","duration":"160.986942ms","start":"2026-08-06T01:47:49.195233Z","end":"2026-08-06T01:47:49.35622Z","steps":["trace[1488111361] 'read index received'  (duration: 136.147179ms)","trace[1488111361] 'applied index is now lower than readState.Index'  (duration: 24.837433ms)"],"step_count":2}
{"level":"info","ts":"2026-08-06T01:47:49.356312Z","caller":"traceutil/trace.go:171","msg":"trace[509439557] transaction","detail":"{read_only:false; response_revision:22449; number_of_response:1; }","duration":"163.112883ms","start":"2026-08-06T01:47:49.193143Z","end":"2026-08-06T01:47:49.356256Z","steps":["trace[509439557] 'process raft request'  (duration: 138.243729ms)","trace[509439557] 'compare'  (duration: 24.496737ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-06T01:47:49.356598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.351389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/openstack/load-balancer\" ","response":"range_response_count:1 size:715"}
{"level":"info","ts":"2026-08-06T01:47:49.356664Z","caller":"traceutil/trace.go:171","msg":"trace[1388539034] range","detail":"{range_begin:/registry/ingress/openstack/load-balancer; range_end:; response_count:1; response_revision:22449; }","duration":"161.4555ms","start":"2026-08-06T01:47:49.19519Z","end":"2026-08-06T01:47:49.356645Z","steps":["trace[1388539034] 'agreement among raft nodes before linearized reading'  (duration: 161.141244ms)"],"step_count":1}
{"level":"info","ts":"2026-08-06T01:48:56.118603Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20020}
{"level":"info","ts":"2026-08-06T01:48:56.232129Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20020,"took":"108.044301ms","hash":3307549746,"current-db-size-bytes":59424768,"current-db-size":"59 MB","current-db-size-in-use-bytes":43118592,"current-db-size-in-use":"43 MB"}
{"level":"info","ts":"2026-08-06T01:48:56.232189Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3307549746,"revision":20020,"compact-revision":17755}
{"level":"info","ts":"2026-08-06T01:53:56.125097Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23223}
{"level":"info","ts":"2026-08-06T01:53:56.269978Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23223,"took":"139.812934ms","hash":267197241,"current-db-size-bytes":59424768,"current-db-size":"59 MB","current-db-size-in-use-bytes":32083968,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-06T01:53:56.270051Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":267197241,"revision":23223,"compact-revision":20020}