{"level":"warn","ts":"2026-07-16T00:17:51.210417Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-07-16T00:17:51.21054Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.89:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.89:2380","--initial-cluster=instance=https://199.204.45.89:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.89:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.89:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-07-16T00:17:51.210607Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-07-16T00:17:51.210615Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.89:2380"]}
{"level":"info","ts":"2026-07-16T00:17:51.210637Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-07-16T00:17:51.21192Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"]}
{"level":"info","ts":"2026-07-16T00:17:51.21208Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.89:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-07-16T00:17:51.216938Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.472413ms"}
{"level":"info","ts":"2026-07-16T00:17:51.224083Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c3b8446219deb8c1","cluster-id":"fe02a46d8aa9751f"}
{"level":"info","ts":"2026-07-16T00:17:51.224134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=()"}
{"level":"info","ts":"2026-07-16T00:17:51.224204Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 0"}
{"level":"info","ts":"2026-07-16T00:17:51.224218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c3b8446219deb8c1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-07-16T00:17:51.224226Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 1"}
{"level":"info","ts":"2026-07-16T00:17:51.224304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"}
{"level":"warn","ts":"2026-07-16T00:17:51.230713Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-07-16T00:17:51.234911Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-07-16T00:17:51.236301Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-07-16T00:17:51.240568Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c3b8446219deb8c1","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-07-16T00:17:51.240653Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c3b8446219deb8c1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-07-16T00:17:51.240842Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-07-16T00:17:51.240882Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-07-16T00:17:51.24089Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-07-16T00:17:51.245962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"}
{"level":"info","ts":"2026-07-16T00:17:51.246716Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","added-peer-id":"c3b8446219deb8c1","added-peer-peer-urls":["https://199.204.45.89:2380"]}
{"level":"info","ts":"2026-07-16T00:17:51.249226Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-07-16T00:17:51.249499Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c3b8446219deb8c1","initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-07-16T00:17:51.249533Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-07-16T00:17:51.249728Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.89:2380"}
{"level":"info","ts":"2026-07-16T00:17:51.249749Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.89:2380"}
{"level":"info","ts":"2026-07-16T00:17:51.324682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 is starting a new election at term 1"}
{"level":"info","ts":"2026-07-16T00:17:51.324746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became pre-candidate at term 1"}
{"level":"info","ts":"2026-07-16T00:17:51.324771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgPreVoteResp from c3b8446219deb8c1 at term 1"}
{"level":"info","ts":"2026-07-16T00:17:51.324786Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became candidate at term 2"}
{"level":"info","ts":"2026-07-16T00:17:51.324894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgVoteResp from c3b8446219deb8c1 at term 2"}
{"level":"info","ts":"2026-07-16T00:17:51.324907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became leader at term 2"}
{"level":"info","ts":"2026-07-16T00:17:51.324916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c3b8446219deb8c1 elected leader c3b8446219deb8c1 at term 2"}
{"level":"info","ts":"2026-07-16T00:17:51.327017Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c3b8446219deb8c1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.89:2379]}","request-path":"/0/members/c3b8446219deb8c1/attributes","cluster-id":"fe02a46d8aa9751f","publish-timeout":"7s"}
{"level":"info","ts":"2026-07-16T00:17:51.327059Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-07-16T00:17:51.327192Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-07-16T00:17:51.327343Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-07-16T00:17:51.327417Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-07-16T00:17:51.327367Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-16T00:17:51.329062Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-16T00:17:51.329189Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-16T00:17:51.329278Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-16T00:17:51.331766Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.89:2379"}
{"level":"info","ts":"2026-07-16T00:17:51.333135Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-07-16T00:17:58.128891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.080913ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313097243741420209 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/kube-controller-manager-instance\" mod_revision:275 > success:<request_put:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" value_size:6669 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-07-16T00:17:58.129103Z","caller":"traceutil/trace.go:171","msg":"trace[1614539140] linearizableReadLoop","detail":"{readStateIndex:319; appliedIndex:317; }","duration":"339.629664ms","start":"2026-07-16T00:17:57.789454Z","end":"2026-07-16T00:17:58.129084Z","steps":["trace[1614539140] 'read index received'  (duration: 26.603622ms)","trace[1614539140] 'applied index is now lower than readState.Index'  (duration: 313.025142ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-16T00:17:58.129202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.745466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-07-16T00:17:58.129234Z","caller":"traceutil/trace.go:171","msg":"trace[76067146] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:308; }","duration":"339.812269ms","start":"2026-07-16T00:17:57.789413Z","end":"2026-07-16T00:17:58.129225Z","steps":["trace[76067146] 'agreement among raft nodes before linearized reading'  (duration: 339.734927ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:17:58.129271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:17:57.789399Z","time spent":"339.863779ms","remote":"127.0.0.1:54060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-07-16T00:17:58.129461Z","caller":"traceutil/trace.go:171","msg":"trace[932975067] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"606.580182ms","start":"2026-07-16T00:17:57.522835Z","end":"2026-07-16T00:17:58.129415Z","steps":["trace[932975067] 'process raft request'  (duration: 606.195625ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:17:58.129572Z","caller":"traceutil/trace.go:171","msg":"trace[130811141] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"633.566302ms","start":"2026-07-16T00:17:57.495989Z","end":"2026-07-16T00:17:58.129556Z","steps":["trace[130811141] 'process raft request'  (duration: 320.0744ms)","trace[130811141] 'compare'  (duration: 311.998552ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-16T00:17:58.129892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:17:57.52281Z","time spent":"606.97276ms","remote":"127.0.0.1:54000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":199,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/pv-protection-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/pv-protection-controller\" value_size:129 >> failure:<>"}
{"level":"warn","ts":"2026-07-16T00:17:58.129846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:17:57.495975Z","time spent":"633.826508ms","remote":"127.0.0.1:53990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6736,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-controller-manager-instance\" mod_revision:275 > success:<request_put:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" value_size:6669 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" > >"}
{"level":"warn","ts":"2026-07-16T00:17:58.442472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.924981ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313097243741420214 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:250 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-07-16T00:17:58.442669Z","caller":"traceutil/trace.go:171","msg":"trace[1424663635] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"308.871295ms","start":"2026-07-16T00:17:58.133751Z","end":"2026-07-16T00:17:58.442622Z","steps":["trace[1424663635] 'process raft request'  (duration: 191.709378ms)","trace[1424663635] 'compare'  (duration: 116.788619ms)"],"step_count":2}
{"level":"info","ts":"2026-07-16T00:17:58.442737Z","caller":"traceutil/trace.go:171","msg":"trace[1419244439] linearizableReadLoop","detail":"{readStateIndex:320; appliedIndex:319; }","duration":"308.138171ms","start":"2026-07-16T00:17:58.134577Z","end":"2026-07-16T00:17:58.442715Z","steps":["trace[1419244439] 'read index received'  (duration: 190.882372ms)","trace[1419244439] 'applied index is now lower than readState.Index'  (duration: 117.253078ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-16T00:17:58.442821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:17:58.133732Z","time spent":"309.010158ms","remote":"127.0.0.1:54060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:250 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-07-16T00:17:58.442865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.273213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-07-16T00:17:58.442904Z","caller":"traceutil/trace.go:171","msg":"trace[722516663] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:310; }","duration":"308.333644ms","start":"2026-07-16T00:17:58.134561Z","end":"2026-07-16T00:17:58.442895Z","steps":["trace[722516663] 'agreement among raft nodes before linearized reading'  (duration: 308.226831ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:17:58.442944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:17:58.134555Z","time spent":"308.381325ms","remote":"127.0.0.1:53938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":375,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"info","ts":"2026-07-16T00:17:58.443277Z","caller":"traceutil/trace.go:171","msg":"trace[2049277416] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"304.189382ms","start":"2026-07-16T00:17:58.139071Z","end":"2026-07-16T00:17:58.443261Z","steps":["trace[2049277416] 'process raft request'  (duration: 303.585249ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:17:58.443401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:17:58.139063Z","time spent":"304.265752ms","remote":"127.0.0.1:53990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5139,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/etcd-instance\" mod_revision:277 > success:<request_put:<key:\"/registry/pods/kube-system/etcd-instance\" value_size:5091 >> failure:<request_range:<key:\"/registry/pods/kube-system/etcd-instance\" > >"}
{"level":"info","ts":"2026-07-16T00:18:28.001723Z","caller":"traceutil/trace.go:171","msg":"trace[1697140850] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"257.811993ms","start":"2026-07-16T00:18:27.743888Z","end":"2026-07-16T00:18:28.0017Z","steps":["trace[1697140850] 'process raft request'  (duration: 257.683351ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:18:28.00926Z","caller":"traceutil/trace.go:171","msg":"trace[197376130] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"264.204644ms","start":"2026-07-16T00:18:27.745031Z","end":"2026-07-16T00:18:28.009236Z","steps":["trace[197376130] 'process raft request'  (duration: 263.929419ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:18:28.009561Z","caller":"traceutil/trace.go:171","msg":"trace[788260114] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"245.55902ms","start":"2026-07-16T00:18:27.76399Z","end":"2026-07-16T00:18:28.009549Z","steps":["trace[788260114] 'process raft request'  (duration: 245.201744ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:18:28.009659Z","caller":"traceutil/trace.go:171","msg":"trace[2109972634] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"238.553869ms","start":"2026-07-16T00:18:27.771026Z","end":"2026-07-16T00:18:28.00958Z","steps":["trace[2109972634] 'process raft request'  (duration: 238.222193ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:18:28.009708Z","caller":"traceutil/trace.go:171","msg":"trace[1279732072] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"256.705464ms","start":"2026-07-16T00:18:27.75296Z","end":"2026-07-16T00:18:28.009666Z","steps":["trace[1279732072] 'process raft request'  (duration: 256.125144ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:18:28.009788Z","caller":"traceutil/trace.go:171","msg":"trace[1146311854] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"238.629081ms","start":"2026-07-16T00:18:27.771081Z","end":"2026-07-16T00:18:28.009711Z","steps":["trace[1146311854] 'process raft request'  (duration: 238.318375ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:18:28.009974Z","caller":"traceutil/trace.go:171","msg":"trace[760910215] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"237.448099ms","start":"2026-07-16T00:18:27.772497Z","end":"2026-07-16T00:18:28.009945Z","steps":["trace[760910215] 'process raft request'  (duration: 236.968751ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:18:28.010133Z","caller":"traceutil/trace.go:171","msg":"trace[2113855278] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"235.114939ms","start":"2026-07-16T00:18:27.775001Z","end":"2026-07-16T00:18:28.010116Z","steps":["trace[2113855278] 'process raft request'  (duration: 234.522238ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:18:28.010381Z","caller":"traceutil/trace.go:171","msg":"trace[220083976] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"235.280911ms","start":"2026-07-16T00:18:27.77509Z","end":"2026-07-16T00:18:28.010371Z","steps":["trace[220083976] 'process raft request'  (duration: 234.538508ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:18:28.010901Z","caller":"traceutil/trace.go:171","msg":"trace[556844676] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"231.499787ms","start":"2026-07-16T00:18:27.779361Z","end":"2026-07-16T00:18:28.010861Z","steps":["trace[556844676] 'process raft request'  (duration: 230.895246ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:18:28.010947Z","caller":"traceutil/trace.go:171","msg":"trace[575038334] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"195.600224ms","start":"2026-07-16T00:18:27.815337Z","end":"2026-07-16T00:18:28.010937Z","steps":["trace[575038334] 'process raft request'  (duration: 195.457401ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:18:28.80613Z","caller":"traceutil/trace.go:171","msg":"trace[1914207143] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"145.542487ms","start":"2026-07-16T00:18:28.660561Z","end":"2026-07-16T00:18:28.806103Z","steps":["trace[1914207143] 'process raft request'  (duration: 81.166953ms)","trace[1914207143] 'compare'  (duration: 63.839575ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-16T00:18:29.195416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.091954ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313097243741420751 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:521 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-07-16T00:18:29.19565Z","caller":"traceutil/trace.go:171","msg":"trace[1276096636] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"316.335082ms","start":"2026-07-16T00:18:28.879291Z","end":"2026-07-16T00:18:29.195626Z","steps":["trace[1276096636] 'process raft request'  (duration: 127.914823ms)","trace[1276096636] 'compare'  (duration: 187.937542ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-16T00:18:29.195763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:28.879281Z","time spent":"316.420214ms","remote":"127.0.0.1:54060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:521 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-07-16T00:18:29.196121Z","caller":"traceutil/trace.go:171","msg":"trace[715558685] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"307.391747ms","start":"2026-07-16T00:18:28.888675Z","end":"2026-07-16T00:18:29.196066Z","steps":["trace[715558685] 'process raft request'  (duration: 306.873818ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:18:29.196259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:28.888652Z","time spent":"307.544139ms","remote":"127.0.0.1:53890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io\" value_size:14558 >> failure:<>"}
{"level":"info","ts":"2026-07-16T00:18:29.199191Z","caller":"traceutil/trace.go:171","msg":"trace[1701486498] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"205.855121ms","start":"2026-07-16T00:18:28.993306Z","end":"2026-07-16T00:18:29.199161Z","steps":["trace[1701486498] 'process raft request'  (duration: 202.450972ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:18:34.084175Z","caller":"traceutil/trace.go:171","msg":"trace[788667706] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"111.310736ms","start":"2026-07-16T00:18:33.972838Z","end":"2026-07-16T00:18:34.084149Z","steps":["trace[788667706] 'process raft request'  (duration: 111.136292ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:18:34.261725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.863937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-16T00:18:34.261802Z","caller":"traceutil/trace.go:171","msg":"trace[2035092467] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"100.975968ms","start":"2026-07-16T00:18:34.16081Z","end":"2026-07-16T00:18:34.261786Z","steps":["trace[2035092467] 'range keys from in-memory index tree'  (duration: 100.814077ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:18:34.319961Z","caller":"traceutil/trace.go:171","msg":"trace[2040351965] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"114.110802ms","start":"2026-07-16T00:18:34.205801Z","end":"2026-07-16T00:18:34.319911Z","steps":["trace[2040351965] 'process raft request'  (duration: 112.492995ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:18:34.932857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.652757ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313097243741420910 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-07-16T00:18:34.933157Z","caller":"traceutil/trace.go:171","msg":"trace[511218254] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"448.251209ms","start":"2026-07-16T00:18:34.48488Z","end":"2026-07-16T00:18:34.933131Z","steps":["trace[511218254] 'read index received'  (duration: 214.164685ms)","trace[511218254] 'applied index is now lower than readState.Index'  (duration: 234.084544ms)"],"step_count":2}
{"level":"info","ts":"2026-07-16T00:18:34.933429Z","caller":"traceutil/trace.go:171","msg":"trace[889658913] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"557.591591ms","start":"2026-07-16T00:18:34.375821Z","end":"2026-07-16T00:18:34.933413Z","steps":["trace[889658913] 'process raft request'  (duration: 323.279413ms)","trace[889658913] 'compare'  (duration: 233.506864ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-16T00:18:34.933998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.454756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-07-16T00:18:34.934142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.247935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-cqgwt\" ","response":"range_response_count:1 size:16961"}
{"level":"info","ts":"2026-07-16T00:18:34.934196Z","caller":"traceutil/trace.go:171","msg":"trace[1314236684] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:631; }","duration":"319.59536ms","start":"2026-07-16T00:18:34.61447Z","end":"2026-07-16T00:18:34.934066Z","steps":["trace[1314236684] 'agreement among raft nodes before linearized reading'  (duration: 319.393456ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:18:34.934237Z","caller":"traceutil/trace.go:171","msg":"trace[669200997] range","detail":"{range_begin:/registry/pods/kube-system/cilium-cqgwt; range_end:; response_count:1; response_revision:631; }","duration":"449.380917ms","start":"2026-07-16T00:18:34.484831Z","end":"2026-07-16T00:18:34.934212Z","steps":["trace[669200997] 'agreement among raft nodes before linearized reading'  (duration: 449.143793ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:18:34.934287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:34.484808Z","time spent":"449.46981ms","remote":"127.0.0.1:53990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-cqgwt\" "}
{"level":"warn","ts":"2026-07-16T00:18:34.934328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:34.614444Z","time spent":"319.868614ms","remote":"127.0.0.1:54060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-07-16T00:18:34.934472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:34.375783Z","time spent":"557.741523ms","remote":"127.0.0.1:54256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>"}
{"level":"warn","ts":"2026-07-16T00:18:34.934167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.733365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.89\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-07-16T00:18:34.934847Z","caller":"traceutil/trace.go:171","msg":"trace[846567640] range","detail":"{range_begin:/registry/masterleases/199.204.45.89; range_end:; response_count:1; response_revision:631; }","duration":"225.492798ms","start":"2026-07-16T00:18:34.709307Z","end":"2026-07-16T00:18:34.9348Z","steps":["trace[846567640] 'agreement among raft nodes before linearized reading'  (duration: 224.675443ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:18:49.421646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.384618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-16T00:18:49.421802Z","caller":"traceutil/trace.go:171","msg":"trace[445420641] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:791; }","duration":"260.617506ms","start":"2026-07-16T00:18:49.161157Z","end":"2026-07-16T00:18:49.421774Z","steps":["trace[445420641] 'range keys from in-memory index tree'  (duration: 260.272584ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:18:49.421692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.088606ms","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-07-16T00:18:49.422081Z","caller":"traceutil/trace.go:171","msg":"trace[448364107] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:791; }","duration":"133.536961ms","start":"2026-07-16T00:18:49.288513Z","end":"2026-07-16T00:18:49.42205Z","steps":["trace[448364107] 'range keys from in-memory index tree'  (duration: 132.872339ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:19:18.610493Z","caller":"traceutil/trace.go:171","msg":"trace[394455912] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"176.451474ms","start":"2026-07-16T00:19:18.434016Z","end":"2026-07-16T00:19:18.610467Z","steps":["trace[394455912] 'process raft request'  (duration: 176.30331ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:19:18.61111Z","caller":"traceutil/trace.go:171","msg":"trace[1891503817] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"154.364007ms","start":"2026-07-16T00:19:18.45672Z","end":"2026-07-16T00:19:18.611084Z","steps":["trace[1891503817] 'process raft request'  (duration: 154.243454ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:20:04.913594Z","caller":"traceutil/trace.go:171","msg":"trace[1625443733] linearizableReadLoop","detail":"{readStateIndex:1935; appliedIndex:1934; }","duration":"200.061777ms","start":"2026-07-16T00:20:04.713504Z","end":"2026-07-16T00:20:04.913565Z","steps":["trace[1625443733] 'read index received'  (duration: 199.891373ms)","trace[1625443733] 'applied index is now lower than readState.Index'  (duration: 169.194µs)"],"step_count":2}
{"level":"info","ts":"2026-07-16T00:20:04.914065Z","caller":"traceutil/trace.go:171","msg":"trace[1129355476] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"224.959744ms","start":"2026-07-16T00:20:04.689092Z","end":"2026-07-16T00:20:04.914052Z","steps":["trace[1129355476] 'process raft request'  (duration: 224.3629ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:20:04.91424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.719693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.89\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-07-16T00:20:04.914319Z","caller":"traceutil/trace.go:171","msg":"trace[1367786241] range","detail":"{range_begin:/registry/masterleases/199.204.45.89; range_end:; response_count:1; response_revision:1865; }","duration":"200.852145ms","start":"2026-07-16T00:20:04.713449Z","end":"2026-07-16T00:20:04.914302Z","steps":["trace[1367786241] 'agreement among raft nodes before linearized reading'  (duration: 200.61469ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:20:16.081575Z","caller":"traceutil/trace.go:171","msg":"trace[809700346] transaction","detail":"{read_only:false; response_revision:1965; number_of_response:1; }","duration":"111.387619ms","start":"2026-07-16T00:20:15.970156Z","end":"2026-07-16T00:20:16.081544Z","steps":["trace[809700346] 'process raft request'  (duration: 89.310847ms)","trace[809700346] 'compare'  (duration: 21.799486ms)"],"step_count":2}
{"level":"info","ts":"2026-07-16T00:20:16.343451Z","caller":"traceutil/trace.go:171","msg":"trace[1972211156] transaction","detail":"{read_only:false; response_revision:1967; number_of_response:1; }","duration":"257.079806ms","start":"2026-07-16T00:20:16.086342Z","end":"2026-07-16T00:20:16.343422Z","steps":["trace[1972211156] 'process raft request'  (duration: 225.572283ms)","trace[1972211156] 'compare'  (duration: 31.206587ms)"],"step_count":2}
{"level":"info","ts":"2026-07-16T00:20:16.343907Z","caller":"traceutil/trace.go:171","msg":"trace[2031564708] linearizableReadLoop","detail":"{readStateIndex:2041; appliedIndex:2039; }","duration":"181.939549ms","start":"2026-07-16T00:20:16.161917Z","end":"2026-07-16T00:20:16.343857Z","steps":["trace[2031564708] 'read index received'  (duration: 150.014558ms)","trace[2031564708] 'applied index is now lower than readState.Index'  (duration: 31.922821ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-16T00:20:16.34427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.319698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-16T00:20:16.344375Z","caller":"traceutil/trace.go:171","msg":"trace[171619733] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1968; }","duration":"182.500363ms","start":"2026-07-16T00:20:16.161855Z","end":"2026-07-16T00:20:16.344355Z","steps":["trace[171619733] 'agreement among raft nodes before linearized reading'  (duration: 182.169306ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:20:16.34437Z","caller":"traceutil/trace.go:171","msg":"trace[2085091380] transaction","detail":"{read_only:false; response_revision:1968; number_of_response:1; }","duration":"239.645667ms","start":"2026-07-16T00:20:16.104642Z","end":"2026-07-16T00:20:16.344287Z","steps":["trace[2085091380] 'process raft request'  (duration: 238.724277ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:20:20.399647Z","caller":"traceutil/trace.go:171","msg":"trace[1364313930] linearizableReadLoop","detail":"{readStateIndex:2060; appliedIndex:2058; }","duration":"239.636773ms","start":"2026-07-16T00:20:20.159984Z","end":"2026-07-16T00:20:20.39962Z","steps":["trace[1364313930] 'read index received'  (duration: 239.343957ms)","trace[1364313930] 'applied index is now lower than readState.Index'  (duration: 291.716µs)"],"step_count":2}
{"level":"info","ts":"2026-07-16T00:20:20.400033Z","caller":"traceutil/trace.go:171","msg":"trace[1067437729] transaction","detail":"{read_only:false; response_revision:1986; number_of_response:1; }","duration":"276.630979ms","start":"2026-07-16T00:20:20.123375Z","end":"2026-07-16T00:20:20.400006Z","steps":["trace[1067437729] 'process raft request'  (duration: 276.019855ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:20:20.400045Z","caller":"traceutil/trace.go:171","msg":"trace[1961451154] transaction","detail":"{read_only:false; response_revision:1987; number_of_response:1; }","duration":"254.687715ms","start":"2026-07-16T00:20:20.145332Z","end":"2026-07-16T00:20:20.40002Z","steps":["trace[1961451154] 'process raft request'  (duration: 254.227065ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:20:20.400071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.057442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-16T00:20:20.400158Z","caller":"traceutil/trace.go:171","msg":"trace[486038829] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1987; }","duration":"240.177454ms","start":"2026-07-16T00:20:20.15996Z","end":"2026-07-16T00:20:20.400137Z","steps":["trace[486038829] 'agreement among raft nodes before linearized reading'  (duration: 239.9948ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:20:20.400712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.288397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-kkn7v\" ","response":"range_response_count:1 size:5854"}
{"level":"info","ts":"2026-07-16T00:20:20.400783Z","caller":"traceutil/trace.go:171","msg":"trace[1502513505] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-kkn7v; range_end:; response_count:1; response_revision:1987; }","duration":"206.404851ms","start":"2026-07-16T00:20:20.194359Z","end":"2026-07-16T00:20:20.400764Z","steps":["trace[1502513505] 'agreement among raft nodes before linearized reading'  (duration: 205.603634ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:20:38.126164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.232785ms","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-07-16T00:20:38.126325Z","caller":"traceutil/trace.go:171","msg":"trace[1479719054] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2098; }","duration":"116.427828ms","start":"2026-07-16T00:20:38.009844Z","end":"2026-07-16T00:20:38.126272Z","steps":["trace[1479719054] 'range keys from in-memory index tree'  (duration: 116.00241ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:20:38.76598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.626964ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313097243741423825 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:2091 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-07-16T00:20:38.766327Z","caller":"traceutil/trace.go:171","msg":"trace[1876943292] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"236.102794ms","start":"2026-07-16T00:20:38.530186Z","end":"2026-07-16T00:20:38.766289Z","steps":["trace[1876943292] 'process raft request'  (duration: 59.069512ms)","trace[1876943292] 'compare'  (duration: 176.462741ms)"],"step_count":2}
{"level":"info","ts":"2026-07-16T00:20:39.196789Z","caller":"traceutil/trace.go:171","msg":"trace[423623894] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"172.800604ms","start":"2026-07-16T00:20:39.023955Z","end":"2026-07-16T00:20:39.196756Z","steps":["trace[423623894] 'process raft request'  (duration: 172.56322ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:20:39.599265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.252921ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313097243741423831 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2095 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-07-16T00:20:39.599495Z","caller":"traceutil/trace.go:171","msg":"trace[1593288077] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"397.990918ms","start":"2026-07-16T00:20:39.201472Z","end":"2026-07-16T00:20:39.599463Z","steps":["trace[1593288077] 'process raft request'  (duration: 186.41964ms)","trace[1593288077] 'compare'  (duration: 211.126669ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-16T00:20:39.599641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:20:39.201451Z","time spent":"398.114021ms","remote":"127.0.0.1:54060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2095 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-07-16T00:20:39.599975Z","caller":"traceutil/trace.go:171","msg":"trace[337603425] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"396.129659ms","start":"2026-07-16T00:20:39.203814Z","end":"2026-07-16T00:20:39.599944Z","steps":["trace[337603425] 'process raft request'  (duration: 395.572768ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:20:39.600168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:20:39.203791Z","time spent":"396.295123ms","remote":"127.0.0.1:54060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2094 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-07-16T00:20:39.852027Z","caller":"traceutil/trace.go:171","msg":"trace[798216138] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"247.89471ms","start":"2026-07-16T00:20:39.604109Z","end":"2026-07-16T00:20:39.852004Z","steps":["trace[798216138] 'process raft request'  (duration: 247.742847ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:20:40.074209Z","caller":"traceutil/trace.go:171","msg":"trace[2051627298] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"161.963854ms","start":"2026-07-16T00:20:39.912217Z","end":"2026-07-16T00:20:40.074181Z","steps":["trace[2051627298] 'process raft request'  (duration: 161.385931ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:21:35.17259Z","caller":"traceutil/trace.go:171","msg":"trace[118986156] transaction","detail":"{read_only:false; response_revision:2512; number_of_response:1; }","duration":"148.389897ms","start":"2026-07-16T00:21:35.024172Z","end":"2026-07-16T00:21:35.172562Z","steps":["trace[118986156] 'process raft request'  (duration: 148.197903ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:22:08.044762Z","caller":"traceutil/trace.go:171","msg":"trace[973418774] transaction","detail":"{read_only:false; response_revision:2692; number_of_response:1; }","duration":"157.282048ms","start":"2026-07-16T00:22:07.887456Z","end":"2026-07-16T00:22:08.044738Z","steps":["trace[973418774] 'process raft request'  (duration: 156.784179ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:22:08.702316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.660995ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313097243741425262 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2685 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-07-16T00:22:08.702489Z","caller":"traceutil/trace.go:171","msg":"trace[766447932] linearizableReadLoop","detail":"{readStateIndex:2795; appliedIndex:2793; }","duration":"160.825163ms","start":"2026-07-16T00:22:08.541648Z","end":"2026-07-16T00:22:08.702473Z","steps":["trace[766447932] 'read index received'  (duration: 11.936263ms)","trace[766447932] 'applied index is now lower than readState.Index'  (duration: 148.88771ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-16T00:22:08.70283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.181711ms","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-07-16T00:22:08.702875Z","caller":"traceutil/trace.go:171","msg":"trace[826917830] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2697; }","duration":"161.274681ms","start":"2026-07-16T00:22:08.541588Z","end":"2026-07-16T00:22:08.702863Z","steps":["trace[826917830] 'agreement among raft nodes before linearized reading'  (duration: 160.975536ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:22:08.702839Z","caller":"traceutil/trace.go:171","msg":"trace[1062206908] transaction","detail":"{read_only:false; response_revision:2696; number_of_response:1; }","duration":"317.55191ms","start":"2026-07-16T00:22:08.385235Z","end":"2026-07-16T00:22:08.702787Z","steps":["trace[1062206908] 'process raft request'  (duration: 168.370434ms)","trace[1062206908] 'compare'  (duration: 148.514763ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-16T00:22:08.703031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:22:08.385184Z","time spent":"317.748283ms","remote":"127.0.0.1:54060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2685 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-07-16T00:22:08.703445Z","caller":"traceutil/trace.go:171","msg":"trace[1234787750] transaction","detail":"{read_only:false; response_revision:2697; number_of_response:1; }","duration":"275.354572ms","start":"2026-07-16T00:22:08.427482Z","end":"2026-07-16T00:22:08.702836Z","steps":["trace[1234787750] 'process raft request'  (duration: 274.936684ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:25:46.587651Z","caller":"traceutil/trace.go:171","msg":"trace[297973875] transaction","detail":"{read_only:false; response_revision:4446; number_of_response:1; }","duration":"100.01628ms","start":"2026-07-16T00:25:46.487609Z","end":"2026-07-16T00:25:46.587625Z","steps":["trace[297973875] 'process raft request'  (duration: 98.958204ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:25:47.666635Z","caller":"traceutil/trace.go:171","msg":"trace[928958156] transaction","detail":"{read_only:false; response_revision:4487; number_of_response:1; }","duration":"139.495083ms","start":"2026-07-16T00:25:47.527122Z","end":"2026-07-16T00:25:47.666617Z","steps":["trace[928958156] 'process raft request'  (duration: 139.305878ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:25:47.674591Z","caller":"traceutil/trace.go:171","msg":"trace[61717426] linearizableReadLoop","detail":"{readStateIndex:4656; appliedIndex:4654; }","duration":"141.350049ms","start":"2026-07-16T00:25:47.533221Z","end":"2026-07-16T00:25:47.674571Z","steps":["trace[61717426] 'read index received'  (duration: 133.200739ms)","trace[61717426] 'applied index is now lower than readState.Index'  (duration: 8.14865ms)"],"step_count":2}
{"level":"info","ts":"2026-07-16T00:25:47.674662Z","caller":"traceutil/trace.go:171","msg":"trace[2084820870] transaction","detail":"{read_only:false; response_revision:4488; number_of_response:1; }","duration":"146.935484ms","start":"2026-07-16T00:25:47.52771Z","end":"2026-07-16T00:25:47.674646Z","steps":["trace[2084820870] 'process raft request'  (duration: 146.741869ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:25:47.674744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.504132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"}
{"level":"info","ts":"2026-07-16T00:25:47.674771Z","caller":"traceutil/trace.go:171","msg":"trace[1355418597] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4488; }","duration":"141.568423ms","start":"2026-07-16T00:25:47.533195Z","end":"2026-07-16T00:25:47.674764Z","steps":["trace[1355418597] 'agreement among raft nodes before linearized reading'  (duration: 141.45491ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:25:49.850793Z","caller":"traceutil/trace.go:171","msg":"trace[1396916140] transaction","detail":"{read_only:false; response_revision:4534; number_of_response:1; }","duration":"171.288379ms","start":"2026-07-16T00:25:49.679478Z","end":"2026-07-16T00:25:49.850766Z","steps":["trace[1396916140] 'process raft request'  (duration: 123.750878ms)","trace[1396916140] 'compare'  (duration: 47.079889ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-16T00:25:50.088087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.714634ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313097243741429696 > lease_revoke:<id:38c19f6849709bde>","response":"size:29"}
{"level":"info","ts":"2026-07-16T00:25:50.088226Z","caller":"traceutil/trace.go:171","msg":"trace[541713696] linearizableReadLoop","detail":"{readStateIndex:4706; appliedIndex:4705; }","duration":"236.859605ms","start":"2026-07-16T00:25:49.85133Z","end":"2026-07-16T00:25:50.08819Z","steps":["trace[541713696] 'read index received'  (duration: 13.010978ms)","trace[541713696] 'applied index is now lower than readState.Index'  (duration: 223.847047ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-16T00:25:50.088831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.4592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ab192d8d-06de-4db9-bb22-0aaec518d154\" ","response":"range_response_count:1 size:4049"}
{"level":"info","ts":"2026-07-16T00:25:50.088933Z","caller":"traceutil/trace.go:171","msg":"trace[26924462] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ab192d8d-06de-4db9-bb22-0aaec518d154; range_end:; response_count:1; response_revision:4534; }","duration":"237.613402ms","start":"2026-07-16T00:25:49.85129Z","end":"2026-07-16T00:25:50.088903Z","steps":["trace[26924462] 'agreement among raft nodes before linearized reading'  (duration: 237.334775ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:25:50.089359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.022921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-07-16T00:25:50.089441Z","caller":"traceutil/trace.go:171","msg":"trace[2004747844] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4534; }","duration":"235.140713ms","start":"2026-07-16T00:25:49.854278Z","end":"2026-07-16T00:25:50.089418Z","steps":["trace[2004747844] 'agreement among raft nodes before linearized reading'  (duration: 234.884006ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:25:50.089617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.060442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-07-16T00:25:50.089668Z","caller":"traceutil/trace.go:171","msg":"trace[1060544665] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4534; }","duration":"126.147774ms","start":"2026-07-16T00:25:49.963508Z","end":"2026-07-16T00:25:50.089656Z","steps":["trace[1060544665] 'agreement among raft nodes before linearized reading'  (duration: 125.945039ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:25:55.09652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.55972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.89\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-07-16T00:25:55.096613Z","caller":"traceutil/trace.go:171","msg":"trace[2075706543] range","detail":"{range_begin:/registry/masterleases/199.204.45.89; range_end:; response_count:1; response_revision:4657; }","duration":"362.702823ms","start":"2026-07-16T00:25:54.733888Z","end":"2026-07-16T00:25:55.096591Z","steps":["trace[2075706543] 'range keys from in-memory index tree'  (duration: 362.345515ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:25:55.09666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:25:54.733868Z","time spent":"362.782044ms","remote":"127.0.0.1:53862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.89\" "}
{"level":"warn","ts":"2026-07-16T00:25:55.096759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.808308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9eb5cde4-9fcd-4dee-83e8-80f8781dc581\" ","response":"range_response_count:1 size:3645"}
{"level":"info","ts":"2026-07-16T00:25:55.096835Z","caller":"traceutil/trace.go:171","msg":"trace[1312613333] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9eb5cde4-9fcd-4dee-83e8-80f8781dc581; range_end:; response_count:1; response_revision:4657; }","duration":"493.933371ms","start":"2026-07-16T00:25:54.602883Z","end":"2026-07-16T00:25:55.096816Z","steps":["trace[1312613333] 'range keys from in-memory index tree'  (duration: 493.653655ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:25:55.096866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:25:54.60286Z","time spent":"493.998753ms","remote":"127.0.0.1:53990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3669,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9eb5cde4-9fcd-4dee-83e8-80f8781dc581\" "}
{"level":"warn","ts":"2026-07-16T00:25:55.096884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.048586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9eb5cde4-9fcd-4dee-83e8-80f8781dc581\" ","response":"range_response_count:1 size:3645"}
{"level":"info","ts":"2026-07-16T00:25:55.096994Z","caller":"traceutil/trace.go:171","msg":"trace[835235269] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9eb5cde4-9fcd-4dee-83e8-80f8781dc581; range_end:; response_count:1; response_revision:4657; }","duration":"338.273681ms","start":"2026-07-16T00:25:54.7587Z","end":"2026-07-16T00:25:55.096974Z","steps":["trace[835235269] 'range keys from in-memory index tree'  (duration: 337.84554ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:25:55.096999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.669506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-07-16T00:25:55.097043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:25:54.758679Z","time spent":"338.351763ms","remote":"127.0.0.1:53990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3669,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9eb5cde4-9fcd-4dee-83e8-80f8781dc581\" "}
{"level":"info","ts":"2026-07-16T00:25:55.097109Z","caller":"traceutil/trace.go:171","msg":"trace[1526005442] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:4657; }","duration":"408.85744ms","start":"2026-07-16T00:25:54.688215Z","end":"2026-07-16T00:25:55.097072Z","steps":["trace[1526005442] 'count revisions from in-memory index tree'  (duration: 408.578984ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:25:55.097167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:25:54.688192Z","time spent":"408.962533ms","remote":"127.0.0.1:57986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "}
{"level":"info","ts":"2026-07-16T00:25:55.105806Z","caller":"traceutil/trace.go:171","msg":"trace[301756521] transaction","detail":"{read_only:false; response_revision:4658; number_of_response:1; }","duration":"278.720818ms","start":"2026-07-16T00:25:54.827066Z","end":"2026-07-16T00:25:55.105787Z","steps":["trace[301756521] 'process raft request'  (duration: 278.578085ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:25:55.309282Z","caller":"traceutil/trace.go:171","msg":"trace[26125810] linearizableReadLoop","detail":"{readStateIndex:4832; appliedIndex:4830; }","duration":"210.209995ms","start":"2026-07-16T00:25:55.099048Z","end":"2026-07-16T00:25:55.309258Z","steps":["trace[26125810] 'read index received'  (duration: 6.63307ms)","trace[26125810] 'applied index is now lower than readState.Index'  (duration: 203.575835ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-16T00:25:55.309746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.042816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-16T00:25:55.309799Z","caller":"traceutil/trace.go:171","msg":"trace[511917355] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4659; }","duration":"149.142817ms","start":"2026-07-16T00:25:55.160645Z","end":"2026-07-16T00:25:55.309788Z","steps":["trace[511917355] 'agreement among raft nodes before linearized reading'  (duration: 149.001383ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:25:55.31022Z","caller":"traceutil/trace.go:171","msg":"trace[1515289781] transaction","detail":"{read_only:false; response_revision:4659; number_of_response:1; }","duration":"205.313175ms","start":"2026-07-16T00:25:55.104882Z","end":"2026-07-16T00:25:55.310195Z","steps":["trace[1515289781] 'process raft request'  (duration: 204.273411ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:25:55.310719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.659439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-07-16T00:25:55.310949Z","caller":"traceutil/trace.go:171","msg":"trace[580611022] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4659; }","duration":"211.911497ms","start":"2026-07-16T00:25:55.099022Z","end":"2026-07-16T00:25:55.310934Z","steps":["trace[580611022] 'agreement among raft nodes before linearized reading'  (duration: 210.561704ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:25:57.952424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.466117ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313097243741430069 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/cilium.io/ciliumendpoints/local-path-storage/helper-pod-create-pvc-9eb5cde4-9fcd-4dee-83e8-80f8781dc581\" mod_revision:4649 > success:<request_delete_range:<key:\"/registry/cilium.io/ciliumendpoints/local-path-storage/helper-pod-create-pvc-9eb5cde4-9fcd-4dee-83e8-80f8781dc581\" > > failure:<request_range:<key:\"/registry/cilium.io/ciliumendpoints/local-path-storage/helper-pod-create-pvc-9eb5cde4-9fcd-4dee-83e8-80f8781dc581\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-16T00:25:57.95257Z","caller":"traceutil/trace.go:171","msg":"trace[1792089059] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4703; }","duration":"127.935377ms","start":"2026-07-16T00:25:57.824611Z","end":"2026-07-16T00:25:57.952546Z","steps":["trace[1792089059] 'process raft request'  (duration: 26.126451ms)","trace[1792089059] 'compare'  (duration: 101.304263ms)"],"step_count":2}
{"level":"info","ts":"2026-07-16T00:25:58.290377Z","caller":"traceutil/trace.go:171","msg":"trace[1123834436] linearizableReadLoop","detail":"{readStateIndex:4879; appliedIndex:4878; }","duration":"111.432144ms","start":"2026-07-16T00:25:58.17892Z","end":"2026-07-16T00:25:58.290352Z","steps":["trace[1123834436] 'read index received'  (duration: 111.206679ms)","trace[1123834436] 'applied index is now lower than readState.Index'  (duration: 224.675µs)"],"step_count":2}
{"level":"warn","ts":"2026-07-16T00:25:58.290719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.71158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-07-16T00:25:58.290748Z","caller":"traceutil/trace.go:171","msg":"trace[946455771] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4705; }","duration":"111.908016ms","start":"2026-07-16T00:25:58.178832Z","end":"2026-07-16T00:25:58.29074Z","steps":["trace[946455771] 'agreement among raft nodes before linearized reading'  (duration: 111.62162ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:25:58.29074Z","caller":"traceutil/trace.go:171","msg":"trace[1664885686] transaction","detail":"{read_only:false; response_revision:4705; number_of_response:1; }","duration":"116.20771ms","start":"2026-07-16T00:25:58.174308Z","end":"2026-07-16T00:25:58.290516Z","steps":["trace[1664885686] 'process raft request'  (duration: 115.881352ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:26:09.235808Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313097243741430374,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-07-16T00:26:09.646722Z","caller":"traceutil/trace.go:171","msg":"trace[1388254222] transaction","detail":"{read_only:false; response_revision:4830; number_of_response:1; }","duration":"913.113761ms","start":"2026-07-16T00:26:08.733584Z","end":"2026-07-16T00:26:09.646698Z","steps":["trace[1388254222] 'process raft request'  (duration: 912.868725ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:26:09.646841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:26:08.733559Z","time spent":"913.217874ms","remote":"127.0.0.1:53914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":731,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/openstack/rabbitmq-keystone.18c29d7af1fb8024\" mod_revision:4643 > success:<request_put:<key:\"/registry/events/openstack/rabbitmq-keystone.18c29d7af1fb8024\" value_size:652 lease:4089725206886653455 >> failure:<request_range:<key:\"/registry/events/openstack/rabbitmq-keystone.18c29d7af1fb8024\" > >"}
{"level":"info","ts":"2026-07-16T00:26:10.018789Z","caller":"traceutil/trace.go:171","msg":"trace[464426590] linearizableReadLoop","detail":"{readStateIndex:5010; appliedIndex:5007; }","duration":"1.283928576s","start":"2026-07-16T00:26:08.734843Z","end":"2026-07-16T00:26:10.018771Z","steps":["trace[464426590] 'read index received'  (duration: 911.735398ms)","trace[464426590] 'applied index is now lower than readState.Index'  (duration: 372.192228ms)"],"step_count":2}
{"level":"info","ts":"2026-07-16T00:26:10.01906Z","caller":"traceutil/trace.go:171","msg":"trace[1994152984] transaction","detail":"{read_only:false; response_revision:4832; number_of_response:1; }","duration":"870.143863ms","start":"2026-07-16T00:26:09.148901Z","end":"2026-07-16T00:26:10.019045Z","steps":["trace[1994152984] 'process raft request'  (duration: 869.775984ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:26:10.019265Z","caller":"traceutil/trace.go:171","msg":"trace[1312044570] transaction","detail":"{read_only:false; response_revision:4831; number_of_response:1; }","duration":"1.277891153s","start":"2026-07-16T00:26:08.741358Z","end":"2026-07-16T00:26:10.019249Z","steps":["trace[1312044570] 'process raft request'  (duration: 1.277195036s)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:26:10.019264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:26:09.148872Z","time spent":"870.241754ms","remote":"127.0.0.1:54060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:4817 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-07-16T00:26:10.019404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:26:08.741342Z","time spent":"1.277997705s","remote":"127.0.0.1:53990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10666,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" mod_revision:4725 > success:<request_put:<key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" value_size:10607 >> failure:<request_range:<key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" > >"}
{"level":"warn","ts":"2026-07-16T00:26:10.019527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.22074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18c29d7af23e4a04\" ","response":"range_response_count:1 size:740"}
{"level":"info","ts":"2026-07-16T00:26:10.019585Z","caller":"traceutil/trace.go:171","msg":"trace[340917196] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18c29d7af23e4a04; range_end:; response_count:1; response_revision:4833; }","duration":"367.293373ms","start":"2026-07-16T00:26:09.652271Z","end":"2026-07-16T00:26:10.019564Z","steps":["trace[340917196] 'agreement among raft nodes before linearized reading'  (duration: 367.18608ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:26:10.01963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:26:09.652259Z","time spent":"367.362573ms","remote":"127.0.0.1:53914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":764,"request content":"key:\"/registry/events/openstack/rabbitmq-keystone.18c29d7af23e4a04\" "}
{"level":"warn","ts":"2026-07-16T00:26:10.019653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.14779811s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-07-16T00:26:10.019746Z","caller":"traceutil/trace.go:171","msg":"trace[2071086584] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:4833; }","duration":"1.147968944s","start":"2026-07-16T00:26:08.871761Z","end":"2026-07-16T00:26:10.01973Z","steps":["trace[2071086584] 'agreement among raft nodes before linearized reading'  (duration: 1.147804961s)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:26:10.019786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:26:08.87174Z","time spent":"1.148038087s","remote":"127.0.0.1:53980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":4,"response size":31,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "}
{"level":"warn","ts":"2026-07-16T00:26:10.019784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.457216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-07-16T00:26:10.019839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.206524396s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-16T00:26:10.019866Z","caller":"traceutil/trace.go:171","msg":"trace[1658314855] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4833; }","duration":"439.576828ms","start":"2026-07-16T00:26:09.580278Z","end":"2026-07-16T00:26:10.019854Z","steps":["trace[1658314855] 'agreement among raft nodes before linearized reading'  (duration: 439.367093ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:26:10.019881Z","caller":"traceutil/trace.go:171","msg":"trace[1008144380] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:4833; }","duration":"1.206605829s","start":"2026-07-16T00:26:08.813263Z","end":"2026-07-16T00:26:10.019869Z","steps":["trace[1008144380] 'agreement among raft nodes before linearized reading'  (duration: 1.206543478s)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:26:10.019911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:26:08.813242Z","time spent":"1.20666077s","remote":"127.0.0.1:59508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true "}
{"level":"warn","ts":"2026-07-16T00:26:10.019903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:26:09.580256Z","time spent":"439.63633ms","remote":"127.0.0.1:54060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-07-16T00:26:10.019411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.257837147s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-07-16T00:26:10.020244Z","caller":"traceutil/trace.go:171","msg":"trace[1455770289] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4833; }","duration":"1.258686017s","start":"2026-07-16T00:26:08.761521Z","end":"2026-07-16T00:26:10.020207Z","steps":["trace[1455770289] 'agreement among raft nodes before linearized reading'  (duration: 1.257725974s)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:26:10.020287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:26:08.761508Z","time spent":"1.258766988s","remote":"127.0.0.1:53980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1889,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "}
{"level":"warn","ts":"2026-07-16T00:26:10.020385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.393345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-07-16T00:26:10.020476Z","caller":"traceutil/trace.go:171","msg":"trace[1909305117] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4833; }","duration":"610.538218ms","start":"2026-07-16T00:26:09.409921Z","end":"2026-07-16T00:26:10.020459Z","steps":["trace[1909305117] 'agreement among raft nodes before linearized reading'  (duration: 609.626846ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:26:10.020525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:26:09.409826Z","time spent":"610.683931ms","remote":"127.0.0.1:54060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-07-16T00:26:10.019002Z","caller":"traceutil/trace.go:171","msg":"trace[284560856] transaction","detail":"{read_only:false; response_revision:4833; number_of_response:1; }","duration":"495.594149ms","start":"2026-07-16T00:26:09.523358Z","end":"2026-07-16T00:26:10.018953Z","steps":["trace[284560856] 'process raft request'  (duration: 495.358063ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:26:10.020909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:26:09.523336Z","time spent":"497.506483ms","remote":"127.0.0.1:54060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:4821 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-07-16T00:26:10.021553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.286670383s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"}
{"level":"warn","ts":"2026-07-16T00:26:10.021594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.927916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-07-16T00:26:10.023581Z","caller":"traceutil/trace.go:171","msg":"trace[82550566] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4833; }","duration":"1.286785944s","start":"2026-07-16T00:26:08.734798Z","end":"2026-07-16T00:26:10.021584Z","steps":["trace[82550566] 'agreement among raft nodes before linearized reading'  (duration: 1.284316905s)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:26:10.023631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:26:08.734782Z","time spent":"1.288837992s","remote":"127.0.0.1:54214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":9663,"request content":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" "}
{"level":"info","ts":"2026-07-16T00:26:10.024089Z","caller":"traceutil/trace.go:171","msg":"trace[385985616] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:4833; }","duration":"480.002978ms","start":"2026-07-16T00:26:09.541614Z","end":"2026-07-16T00:26:10.021617Z","steps":["trace[385985616] 'agreement among raft nodes before linearized reading'  (duration: 478.443231ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:26:10.024249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:26:09.5416Z","time spent":"482.631031ms","remote":"127.0.0.1:39890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":5,"response size":31,"request content":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true "}
{"level":"info","ts":"2026-07-16T00:26:10.181871Z","caller":"traceutil/trace.go:171","msg":"trace[947431829] transaction","detail":"{read_only:false; response_revision:4836; number_of_response:1; }","duration":"154.836662ms","start":"2026-07-16T00:26:10.02701Z","end":"2026-07-16T00:26:10.181846Z","steps":["trace[947431829] 'process raft request'  (duration: 154.635128ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:26:10.182167Z","caller":"traceutil/trace.go:171","msg":"trace[902153912] transaction","detail":"{read_only:false; response_revision:4838; number_of_response:1; }","duration":"154.826222ms","start":"2026-07-16T00:26:10.027313Z","end":"2026-07-16T00:26:10.182139Z","steps":["trace[902153912] 'process raft request'  (duration: 154.615787ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:26:10.182247Z","caller":"traceutil/trace.go:171","msg":"trace[192325253] transaction","detail":"{read_only:false; response_revision:4839; number_of_response:1; }","duration":"153.717427ms","start":"2026-07-16T00:26:10.028472Z","end":"2026-07-16T00:26:10.18219Z","steps":["trace[192325253] 'process raft request'  (duration: 153.519812ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:26:10.182185Z","caller":"traceutil/trace.go:171","msg":"trace[1356309126] transaction","detail":"{read_only:false; response_revision:4837; number_of_response:1; }","duration":"154.929384ms","start":"2026-07-16T00:26:10.027236Z","end":"2026-07-16T00:26:10.182165Z","steps":["trace[1356309126] 'process raft request'  (duration: 154.548446ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:26:10.182347Z","caller":"traceutil/trace.go:171","msg":"trace[1383197664] linearizableReadLoop","detail":"{readStateIndex:5018; appliedIndex:5012; }","duration":"139.54076ms","start":"2026-07-16T00:26:10.042794Z","end":"2026-07-16T00:26:10.182334Z","steps":["trace[1383197664] 'read index received'  (duration: 75.795438ms)","trace[1383197664] 'applied index is now lower than readState.Index'  (duration: 63.744062ms)"],"step_count":2}
{"level":"info","ts":"2026-07-16T00:26:10.182411Z","caller":"traceutil/trace.go:171","msg":"trace[653168930] transaction","detail":"{read_only:false; response_revision:4841; number_of_response:1; }","duration":"101.006274ms","start":"2026-07-16T00:26:10.081373Z","end":"2026-07-16T00:26:10.18238Z","steps":["trace[653168930] 'process raft request'  (duration: 100.867431ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:26:10.182318Z","caller":"traceutil/trace.go:171","msg":"trace[1712834148] transaction","detail":"{read_only:false; response_revision:4840; number_of_response:1; }","duration":"153.622453ms","start":"2026-07-16T00:26:10.0286Z","end":"2026-07-16T00:26:10.182222Z","steps":["trace[1712834148] 'process raft request'  (duration: 153.544821ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:26:10.182547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.341725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-07-16T00:26:10.18259Z","caller":"traceutil/trace.go:171","msg":"trace[1368062476] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4842; }","duration":"155.434586ms","start":"2026-07-16T00:26:10.027142Z","end":"2026-07-16T00:26:10.182576Z","steps":["trace[1368062476] 'agreement among raft nodes before linearized reading'  (duration: 155.280003ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:26:10.181727Z","caller":"traceutil/trace.go:171","msg":"trace[1874236146] transaction","detail":"{read_only:false; response_revision:4835; number_of_response:1; }","duration":"155.306674ms","start":"2026-07-16T00:26:10.026401Z","end":"2026-07-16T00:26:10.181707Z","steps":["trace[1874236146] 'process raft request'  (duration: 92.220627ms)","trace[1874236146] 'compare'  (duration: 62.873392ms)"],"step_count":2}
{"level":"info","ts":"2026-07-16T00:26:10.488741Z","caller":"traceutil/trace.go:171","msg":"trace[681620928] transaction","detail":"{read_only:false; response_revision:4844; number_of_response:1; }","duration":"152.028356ms","start":"2026-07-16T00:26:10.336691Z","end":"2026-07-16T00:26:10.488719Z","steps":["trace[681620928] 'process raft request'  (duration: 151.849271ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:26:10.53868Z","caller":"traceutil/trace.go:171","msg":"trace[1913398769] linearizableReadLoop","detail":"{readStateIndex:5023; appliedIndex:5021; }","duration":"167.962034ms","start":"2026-07-16T00:26:10.370695Z","end":"2026-07-16T00:26:10.538657Z","steps":["trace[1913398769] 'read index received'  (duration: 117.879856ms)","trace[1913398769] 'applied index is now lower than readState.Index'  (duration: 50.080958ms)"],"step_count":2}
{"level":"info","ts":"2026-07-16T00:26:10.538719Z","caller":"traceutil/trace.go:171","msg":"trace[420285787] transaction","detail":"{read_only:false; response_revision:4845; number_of_response:1; }","duration":"180.735186ms","start":"2026-07-16T00:26:10.357961Z","end":"2026-07-16T00:26:10.538696Z","steps":["trace[420285787] 'process raft request'  (duration: 156.329317ms)","trace[420285787] 'compare'  (duration: 24.272796ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-16T00:26:10.538955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.182299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-07-16T00:26:10.539Z","caller":"traceutil/trace.go:171","msg":"trace[1796821099] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4845; }","duration":"168.308512ms","start":"2026-07-16T00:26:10.370678Z","end":"2026-07-16T00:26:10.538987Z","steps":["trace[1796821099] 'agreement among raft nodes before linearized reading'  (duration: 168.091966ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:26:10.776284Z","caller":"traceutil/trace.go:171","msg":"trace[658759710] transaction","detail":"{read_only:false; response_revision:4849; number_of_response:1; }","duration":"143.3649ms","start":"2026-07-16T00:26:10.632892Z","end":"2026-07-16T00:26:10.776257Z","steps":["trace[658759710] 'process raft request'  (duration: 68.947065ms)","trace[658759710] 'compare'  (duration: 74.097007ms)"],"step_count":2}
{"level":"info","ts":"2026-07-16T00:26:10.797294Z","caller":"traceutil/trace.go:171","msg":"trace[820622280] transaction","detail":"{read_only:false; response_revision:4850; number_of_response:1; }","duration":"163.673592ms","start":"2026-07-16T00:26:10.633598Z","end":"2026-07-16T00:26:10.797272Z","steps":["trace[820622280] 'process raft request'  (duration: 163.419636ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:26:10.797446Z","caller":"traceutil/trace.go:171","msg":"trace[1993730897] transaction","detail":"{read_only:false; response_revision:4851; number_of_response:1; }","duration":"160.975637ms","start":"2026-07-16T00:26:10.636451Z","end":"2026-07-16T00:26:10.797427Z","steps":["trace[1993730897] 'process raft request'  (duration: 160.699881ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:26:10.955668Z","caller":"traceutil/trace.go:171","msg":"trace[1246147598] transaction","detail":"{read_only:false; response_revision:4853; number_of_response:1; }","duration":"107.733205ms","start":"2026-07-16T00:26:10.847897Z","end":"2026-07-16T00:26:10.95563Z","steps":["trace[1246147598] 'process raft request'  (duration: 61.083818ms)","trace[1246147598] 'compare'  (duration: 46.458373ms)"],"step_count":2}
{"level":"info","ts":"2026-07-16T00:27:09.252904Z","caller":"traceutil/trace.go:171","msg":"trace[1253199020] transaction","detail":"{read_only:false; response_revision:5325; number_of_response:1; }","duration":"107.841268ms","start":"2026-07-16T00:27:09.145037Z","end":"2026-07-16T00:27:09.252878Z","steps":["trace[1253199020] 'process raft request'  (duration: 107.619103ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:27:09.255399Z","caller":"traceutil/trace.go:171","msg":"trace[270569114] transaction","detail":"{read_only:false; response_revision:5326; number_of_response:1; }","duration":"108.624385ms","start":"2026-07-16T00:27:09.14675Z","end":"2026-07-16T00:27:09.255375Z","steps":["trace[270569114] 'process raft request'  (duration: 108.496222ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:27:51.784094Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2924}
{"level":"info","ts":"2026-07-16T00:27:51.893571Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2924,"took":"107.790794ms","hash":1303270276,"current-db-size-bytes":54505472,"current-db-size":"54 MB","current-db-size-in-use-bytes":29745152,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-07-16T00:27:51.893627Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1303270276,"revision":2924,"compact-revision":-1}
{"level":"info","ts":"2026-07-16T00:29:50.979901Z","caller":"traceutil/trace.go:171","msg":"trace[993168594] transaction","detail":"{read_only:false; response_revision:6449; number_of_response:1; }","duration":"108.030998ms","start":"2026-07-16T00:29:50.871841Z","end":"2026-07-16T00:29:50.979872Z","steps":["trace[993168594] 'process raft request'  (duration: 99.376239ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:30:17.296596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.764082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-16T00:30:17.2967Z","caller":"traceutil/trace.go:171","msg":"trace[992974292] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6641; }","duration":"136.916004ms","start":"2026-07-16T00:30:17.159769Z","end":"2026-07-16T00:30:17.296685Z","steps":["trace[992974292] 'range keys from in-memory index tree'  (duration: 136.697701ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:30:17.30102Z","caller":"traceutil/trace.go:171","msg":"trace[328137741] transaction","detail":"{read_only:false; response_revision:6642; number_of_response:1; }","duration":"127.121865ms","start":"2026-07-16T00:30:17.173877Z","end":"2026-07-16T00:30:17.300999Z","steps":["trace[328137741] 'process raft request'  (duration: 126.932271ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-16T00:30:17.315021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.372021ms","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":"info","ts":"2026-07-16T00:30:17.315083Z","caller":"traceutil/trace.go:171","msg":"trace[228126667] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:6643; }","duration":"127.451833ms","start":"2026-07-16T00:30:17.187619Z","end":"2026-07-16T00:30:17.315071Z","steps":["trace[228126667] 'agreement among raft nodes before linearized reading'  (duration: 127.33507ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:30:17.315064Z","caller":"traceutil/trace.go:171","msg":"trace[1190705742] linearizableReadLoop","detail":"{readStateIndex:6884; appliedIndex:6882; }","duration":"127.227188ms","start":"2026-07-16T00:30:17.187629Z","end":"2026-07-16T00:30:17.314857Z","steps":["trace[1190705742] 'read index received'  (duration: 113.21001ms)","trace[1190705742] 'applied index is now lower than readState.Index'  (duration: 14.016268ms)"],"step_count":2}
{"level":"info","ts":"2026-07-16T00:30:17.31538Z","caller":"traceutil/trace.go:171","msg":"trace[941594109] transaction","detail":"{read_only:false; response_revision:6643; number_of_response:1; }","duration":"138.08412ms","start":"2026-07-16T00:30:17.177276Z","end":"2026-07-16T00:30:17.315361Z","steps":["trace[941594109] 'process raft request'  (duration: 137.450087ms)"],"step_count":1}
{"level":"info","ts":"2026-07-16T00:32:51.792468Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5648}
{"level":"info","ts":"2026-07-16T00:32:51.889341Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5648,"took":"95.690788ms","hash":4191133543,"current-db-size-bytes":54505472,"current-db-size":"54 MB","current-db-size-in-use-bytes":18268160,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-07-16T00:32:51.889395Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4191133543,"revision":5648,"compact-revision":2924}