{"level":"warn","ts":"2026-03-19T17:51:47.607694Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-19T17:51:47.607817Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.15:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.15:2380","--initial-cluster=instance=https://199.19.213.15:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.15:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.15:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-03-19T17:51:47.607903Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-19T17:51:47.60792Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.15:2380"]}
{"level":"info","ts":"2026-03-19T17:51:47.607949Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-03-19T17:51:47.608729Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.15:2379"]}
{"level":"info","ts":"2026-03-19T17:51:47.608827Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.15:2380"],"listen-peer-urls":["https://199.19.213.15:2380"],"advertise-client-urls":["https://199.19.213.15:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.15:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.15:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-03-19T17:51:47.61392Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.789822ms"}
{"level":"info","ts":"2026-03-19T17:51:47.622967Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"11371113779d2d76","cluster-id":"1921549e667ce7d9"}
{"level":"info","ts":"2026-03-19T17:51:47.623117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11371113779d2d76 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-19T17:51:47.623153Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11371113779d2d76 became follower at term 0"}
{"level":"info","ts":"2026-03-19T17:51:47.623165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 11371113779d2d76 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-19T17:51:47.62321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11371113779d2d76 became follower at term 1"}
{"level":"info","ts":"2026-03-19T17:51:47.623253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11371113779d2d76 switched to configuration voters=(1240478997672701302)"}
{"level":"warn","ts":"2026-03-19T17:51:47.635395Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-19T17:51:47.637021Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-19T17:51:47.638568Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-03-19T17:51:47.641335Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"11371113779d2d76","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-19T17:51:47.641682Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-19T17:51:47.641727Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"11371113779d2d76","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-19T17:51:47.641793Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-19T17:51:47.641812Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-19T17:51:47.642391Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11371113779d2d76 switched to configuration voters=(1240478997672701302)"}
{"level":"info","ts":"2026-03-19T17:51:47.6425Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"1921549e667ce7d9","local-member-id":"11371113779d2d76","added-peer-id":"11371113779d2d76","added-peer-peer-urls":["https://199.19.213.15:2380"]}
{"level":"info","ts":"2026-03-19T17:51:47.647551Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-03-19T17:51:47.647664Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.15:2380"}
{"level":"info","ts":"2026-03-19T17:51:47.647723Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.15:2380"}
{"level":"info","ts":"2026-03-19T17:51:47.648Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"11371113779d2d76","initial-advertise-peer-urls":["https://199.19.213.15:2380"],"listen-peer-urls":["https://199.19.213.15:2380"],"advertise-client-urls":["https://199.19.213.15:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.15:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-19T17:51:47.648053Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-19T17:51:47.724784Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11371113779d2d76 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-19T17:51:47.724824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11371113779d2d76 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-19T17:51:47.724865Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11371113779d2d76 received MsgPreVoteResp from 11371113779d2d76 at term 1"}
{"level":"info","ts":"2026-03-19T17:51:47.724884Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11371113779d2d76 became candidate at term 2"}
{"level":"info","ts":"2026-03-19T17:51:47.7249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11371113779d2d76 received MsgVoteResp from 11371113779d2d76 at term 2"}
{"level":"info","ts":"2026-03-19T17:51:47.724917Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11371113779d2d76 became leader at term 2"}
{"level":"info","ts":"2026-03-19T17:51:47.724933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 11371113779d2d76 elected leader 11371113779d2d76 at term 2"}
{"level":"info","ts":"2026-03-19T17:51:47.725829Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-19T17:51:47.726754Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-19T17:51:47.726747Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"11371113779d2d76","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.15:2379]}","request-path":"/0/members/11371113779d2d76/attributes","cluster-id":"1921549e667ce7d9","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-19T17:51:47.726785Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-19T17:51:47.727189Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"1921549e667ce7d9","local-member-id":"11371113779d2d76","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-19T17:51:47.727295Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-19T17:51:47.727427Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-19T17:51:47.727451Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-19T17:51:47.727478Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-19T17:51:47.730189Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-19T17:51:47.730715Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.15:2379"}
{"level":"info","ts":"2026-03-19T17:51:54.275992Z","caller":"traceutil/trace.go:171","msg":"trace[251629546] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"251.262355ms","start":"2026-03-19T17:51:54.02471Z","end":"2026-03-19T17:51:54.275972Z","steps":["trace[251629546] 'process raft request'  (duration: 251.149153ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T17:52:01.01492Z","caller":"traceutil/trace.go:171","msg":"trace[1411120548] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"224.46941ms","start":"2026-03-19T17:52:00.790432Z","end":"2026-03-19T17:52:01.014902Z","steps":["trace[1411120548] 'process raft request'  (duration: 224.360667ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T17:52:01.256947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.955114ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3275978433315056186 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.19.213.15\" mod_revision:195 > success:<request_put:<key:\"/registry/masterleases/199.19.213.15\" value_size:66 lease:3275978433315056184 >> failure:<request_range:<key:\"/registry/masterleases/199.19.213.15\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-19T17:52:01.257031Z","caller":"traceutil/trace.go:171","msg":"trace[1148711268] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"229.364995ms","start":"2026-03-19T17:52:01.027654Z","end":"2026-03-19T17:52:01.257019Z","steps":["trace[1148711268] 'process raft request'  (duration: 86.886898ms)","trace[1148711268] 'compare'  (duration: 141.871373ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T17:52:01.664485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.535528ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3275978433315056191 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:351 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-19T17:52:01.664598Z","caller":"traceutil/trace.go:171","msg":"trace[275536160] linearizableReadLoop","detail":"{readStateIndex:371; appliedIndex:370; }","duration":"191.804098ms","start":"2026-03-19T17:52:01.472776Z","end":"2026-03-19T17:52:01.66458Z","steps":["trace[275536160] 'read index received'  (duration: 58.982µs)","trace[275536160] 'applied index is now lower than readState.Index'  (duration: 191.743746ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T17:52:01.66467Z","caller":"traceutil/trace.go:171","msg":"trace[1171573532] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"345.087137ms","start":"2026-03-19T17:52:01.319537Z","end":"2026-03-19T17:52:01.664624Z","steps":["trace[1171573532] 'process raft request'  (duration: 115.333973ms)","trace[1171573532] 'compare'  (duration: 229.415856ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T17:52:01.664832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T17:52:01.319525Z","time spent":"345.22686ms","remote":"127.0.0.1:53248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:351 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-19T17:52:01.665061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.290589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-19T17:52:01.665194Z","caller":"traceutil/trace.go:171","msg":"trace[1362174949] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:358; }","duration":"192.472102ms","start":"2026-03-19T17:52:01.472699Z","end":"2026-03-19T17:52:01.665171Z","steps":["trace[1362174949] 'agreement among raft nodes before linearized reading'  (duration: 191.973631ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T17:52:27.851038Z","caller":"traceutil/trace.go:171","msg":"trace[2012370736] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"141.387131ms","start":"2026-03-19T17:52:27.709626Z","end":"2026-03-19T17:52:27.851014Z","steps":["trace[2012370736] 'process raft request'  (duration: 141.124794ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T17:52:28.22451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.808663ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3275978433315056510 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:507 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-19T17:52:28.22464Z","caller":"traceutil/trace.go:171","msg":"trace[1349835607] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"368.928793ms","start":"2026-03-19T17:52:27.855691Z","end":"2026-03-19T17:52:28.22462Z","steps":["trace[1349835607] 'process raft request'  (duration: 43.918825ms)","trace[1349835607] 'compare'  (duration: 324.66ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T17:52:28.224788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T17:52:27.855666Z","time spent":"369.074217ms","remote":"127.0.0.1:53248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:507 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-19T17:52:28.233958Z","caller":"traceutil/trace.go:171","msg":"trace[433690380] linearizableReadLoop","detail":"{readStateIndex:537; appliedIndex:534; }","duration":"372.833994ms","start":"2026-03-19T17:52:27.861096Z","end":"2026-03-19T17:52:28.23393Z","steps":["trace[433690380] 'read index received'  (duration: 38.504479ms)","trace[433690380] 'applied index is now lower than readState.Index'  (duration: 334.328675ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T17:52:28.234022Z","caller":"traceutil/trace.go:171","msg":"trace[1656502157] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"377.78369ms","start":"2026-03-19T17:52:27.856196Z","end":"2026-03-19T17:52:28.23398Z","steps":["trace[1656502157] 'process raft request'  (duration: 377.537654ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T17:52:28.234143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.013168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T17:52:28.234191Z","caller":"traceutil/trace.go:171","msg":"trace[1137507146] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:517; }","duration":"373.123321ms","start":"2026-03-19T17:52:27.861055Z","end":"2026-03-19T17:52:28.234178Z","steps":["trace[1137507146] 'agreement among raft nodes before linearized reading'  (duration: 372.982978ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T17:52:28.234229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T17:52:27.861044Z","time spent":"373.174882ms","remote":"127.0.0.1:52972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-19T17:52:28.234256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T17:52:27.856156Z","time spent":"377.992555ms","remote":"127.0.0.1:53248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:508 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-19T17:52:28.234048Z","caller":"traceutil/trace.go:171","msg":"trace[1590174022] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"377.750819ms","start":"2026-03-19T17:52:27.856253Z","end":"2026-03-19T17:52:28.234004Z","steps":["trace[1590174022] 'process raft request'  (duration: 377.631826ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T17:52:28.234396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T17:52:27.856233Z","time spent":"378.117096ms","remote":"127.0.0.1:53248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:509 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-19T17:52:28.569865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.07712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-03-19T17:52:28.569946Z","caller":"traceutil/trace.go:171","msg":"trace[183769759] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:517; }","duration":"110.224203ms","start":"2026-03-19T17:52:28.459703Z","end":"2026-03-19T17:52:28.569927Z","steps":["trace[183769759] 'range keys from in-memory index tree'  (duration: 109.921736ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T17:52:29.97546Z","caller":"traceutil/trace.go:171","msg":"trace[1063189857] linearizableReadLoop","detail":"{readStateIndex:552; appliedIndex:551; }","duration":"114.300538ms","start":"2026-03-19T17:52:29.861121Z","end":"2026-03-19T17:52:29.975421Z","steps":["trace[1063189857] 'read index received'  (duration: 113.919019ms)","trace[1063189857] 'applied index is now lower than readState.Index'  (duration: 379.619µs)"],"step_count":2}
{"level":"info","ts":"2026-03-19T17:52:29.975632Z","caller":"traceutil/trace.go:171","msg":"trace[1529597393] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"124.954587ms","start":"2026-03-19T17:52:29.850611Z","end":"2026-03-19T17:52:29.975565Z","steps":["trace[1529597393] 'process raft request'  (duration: 124.564328ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T17:52:29.975725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.565524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T17:52:29.976003Z","caller":"traceutil/trace.go:171","msg":"trace[1676066553] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:532; }","duration":"114.691308ms","start":"2026-03-19T17:52:29.861081Z","end":"2026-03-19T17:52:29.975773Z","steps":["trace[1676066553] 'agreement among raft nodes before linearized reading'  (duration: 114.492183ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T17:52:47.307894Z","caller":"traceutil/trace.go:171","msg":"trace[59364403] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"348.217552ms","start":"2026-03-19T17:52:46.959636Z","end":"2026-03-19T17:52:47.307854Z","steps":["trace[59364403] 'process raft request'  (duration: 347.925395ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T17:52:47.308127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T17:52:46.959622Z","time spent":"348.389006ms","remote":"127.0.0.1:53254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1611,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/endpointslices/cert-manager/cert-manager-webhook-5k9fk\" mod_revision:642 > success:<request_put:<key:\"/registry/endpointslices/cert-manager/cert-manager-webhook-5k9fk\" value_size:1539 >> failure:<request_range:<key:\"/registry/endpointslices/cert-manager/cert-manager-webhook-5k9fk\" > >"}
{"level":"info","ts":"2026-03-19T17:52:47.309562Z","caller":"traceutil/trace.go:171","msg":"trace[163266362] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"349.243697ms","start":"2026-03-19T17:52:46.960293Z","end":"2026-03-19T17:52:47.309536Z","steps":["trace[163266362] 'process raft request'  (duration: 349.124485ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T17:52:47.309723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T17:52:46.960253Z","time spent":"349.389631ms","remote":"127.0.0.1:53136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1066,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/cert-manager/cert-manager-webhook\" mod_revision:641 > success:<request_put:<key:\"/registry/services/endpoints/cert-manager/cert-manager-webhook\" value_size:996 >> failure:<request_range:<key:\"/registry/services/endpoints/cert-manager/cert-manager-webhook\" > >"}
{"level":"info","ts":"2026-03-19T17:53:39.97735Z","caller":"traceutil/trace.go:171","msg":"trace[1938506326] linearizableReadLoop","detail":"{readStateIndex:1580; appliedIndex:1579; }","duration":"375.063021ms","start":"2026-03-19T17:53:39.602266Z","end":"2026-03-19T17:53:39.977329Z","steps":["trace[1938506326] 'read index received'  (duration: 374.858716ms)","trace[1938506326] 'applied index is now lower than readState.Index'  (duration: 203.365µs)"],"step_count":2}
{"level":"info","ts":"2026-03-19T17:53:39.977414Z","caller":"traceutil/trace.go:171","msg":"trace[472881135] transaction","detail":"{read_only:false; response_revision:1532; number_of_response:1; }","duration":"396.27545ms","start":"2026-03-19T17:53:39.581115Z","end":"2026-03-19T17:53:39.977391Z","steps":["trace[472881135] 'process raft request'  (duration: 396.078255ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T17:53:39.977569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T17:53:39.581094Z","time spent":"396.379802ms","remote":"127.0.0.1:53064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":644,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" mod_revision:1464 > success:<request_put:<key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" value_size:562 >> failure:<request_range:<key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-03-19T17:53:39.977598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.315937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:644"}
{"level":"info","ts":"2026-03-19T17:53:39.977669Z","caller":"traceutil/trace.go:171","msg":"trace[1756387064] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1532; }","duration":"375.41056ms","start":"2026-03-19T17:53:39.60224Z","end":"2026-03-19T17:53:39.977651Z","steps":["trace[1756387064] 'agreement among raft nodes before linearized reading'  (duration: 375.233056ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T17:53:39.977692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.039048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a1b8d5f5-21bc-4ac9-902b-a8e41ec83232\" ","response":"range_response_count:1 size:3626"}
{"level":"warn","ts":"2026-03-19T17:53:39.977716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T17:53:39.60223Z","time spent":"375.473231ms","remote":"127.0.0.1:53064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":666,"request content":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-03-19T17:53:39.977817Z","caller":"traceutil/trace.go:171","msg":"trace[131664699] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a1b8d5f5-21bc-4ac9-902b-a8e41ec83232; range_end:; response_count:1; response_revision:1532; }","duration":"171.16998ms","start":"2026-03-19T17:53:39.806585Z","end":"2026-03-19T17:53:39.977755Z","steps":["trace[131664699] 'agreement among raft nodes before linearized reading'  (duration: 170.929435ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T17:54:22.827896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.850062ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3275978433315059244 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:1841 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:461 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-19T17:54:22.828043Z","caller":"traceutil/trace.go:171","msg":"trace[310986465] linearizableReadLoop","detail":"{readStateIndex:1920; appliedIndex:1919; }","duration":"292.910465ms","start":"2026-03-19T17:54:22.535109Z","end":"2026-03-19T17:54:22.828019Z","steps":["trace[310986465] 'read index received'  (duration: 144.848078ms)","trace[310986465] 'applied index is now lower than readState.Index'  (duration: 148.060907ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T17:54:22.828117Z","caller":"traceutil/trace.go:171","msg":"trace[1470906743] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"317.476045ms","start":"2026-03-19T17:54:22.510584Z","end":"2026-03-19T17:54:22.82806Z","steps":["trace[1470906743] 'process raft request'  (duration: 169.364486ms)","trace[1470906743] 'compare'  (duration: 147.73933ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T17:54:22.828332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T17:54:22.51057Z","time spent":"317.654928ms","remote":"127.0.0.1:53248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":537,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:1841 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:461 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-03-19T17:54:22.82832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.170251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:567"}
{"level":"info","ts":"2026-03-19T17:54:22.828418Z","caller":"traceutil/trace.go:171","msg":"trace[1185611647] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1853; }","duration":"293.311983ms","start":"2026-03-19T17:54:22.535079Z","end":"2026-03-19T17:54:22.828391Z","steps":["trace[1185611647] 'agreement among raft nodes before linearized reading'  (duration: 293.032557ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T17:54:22.907258Z","caller":"traceutil/trace.go:171","msg":"trace[1317780697] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"309.772705ms","start":"2026-03-19T17:54:22.597445Z","end":"2026-03-19T17:54:22.907218Z","steps":["trace[1317780697] 'process raft request'  (duration: 309.598921ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T17:54:22.907451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T17:54:22.597405Z","time spent":"309.940039ms","remote":"127.0.0.1:53248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1792 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-03-19T17:54:22.907293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.209668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-19T17:54:22.907661Z","caller":"traceutil/trace.go:171","msg":"trace[1550653881] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1854; }","duration":"333.598838ms","start":"2026-03-19T17:54:22.574039Z","end":"2026-03-19T17:54:22.907638Z","steps":["trace[1550653881] 'agreement among raft nodes before linearized reading'  (duration: 333.170467ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T17:54:22.907758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T17:54:22.574027Z","time spent":"333.6964ms","remote":"127.0.0.1:53248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-03-19T17:54:23.065489Z","caller":"traceutil/trace.go:171","msg":"trace[1533663674] linearizableReadLoop","detail":"{readStateIndex:1922; appliedIndex:1921; }","duration":"158.318016ms","start":"2026-03-19T17:54:22.907145Z","end":"2026-03-19T17:54:23.065463Z","steps":["trace[1533663674] 'read index received'  (duration: 80.172888ms)","trace[1533663674] 'applied index is now lower than readState.Index'  (duration: 78.144268ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T17:54:23.065654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.846969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-19T17:54:23.065783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.228722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-03-19T17:54:23.0658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.544448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-19T17:54:23.065825Z","caller":"traceutil/trace.go:171","msg":"trace[615772097] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"232.508569ms","start":"2026-03-19T17:54:22.833269Z","end":"2026-03-19T17:54:23.065778Z","steps":["trace[615772097] 'process raft request'  (duration: 154.032423ms)","trace[615772097] 'compare'  (duration: 78.031025ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T17:54:23.06583Z","caller":"traceutil/trace.go:171","msg":"trace[2094934655] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1855; }","duration":"212.349376ms","start":"2026-03-19T17:54:22.853467Z","end":"2026-03-19T17:54:23.065816Z","steps":["trace[2094934655] 'agreement among raft nodes before linearized reading'  (duration: 212.09613ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T17:54:23.065859Z","caller":"traceutil/trace.go:171","msg":"trace[1854486194] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1855; }","duration":"204.093815ms","start":"2026-03-19T17:54:22.861731Z","end":"2026-03-19T17:54:23.065824Z","steps":["trace[1854486194] 'agreement among raft nodes before linearized reading'  (duration: 203.784488ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T17:54:23.065816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.717551ms","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-03-19T17:54:23.065959Z","caller":"traceutil/trace.go:171","msg":"trace[1480218493] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1855; }","duration":"209.891167ms","start":"2026-03-19T17:54:22.85605Z","end":"2026-03-19T17:54:23.065941Z","steps":["trace[1480218493] 'agreement among raft nodes before linearized reading'  (duration: 209.554768ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T17:54:23.06606Z","caller":"traceutil/trace.go:171","msg":"trace[739957442] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1855; }","duration":"209.667201ms","start":"2026-03-19T17:54:22.856191Z","end":"2026-03-19T17:54:23.065858Z","steps":["trace[739957442] 'agreement among raft nodes before linearized reading'  (duration: 209.349012ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T17:54:23.103571Z","caller":"traceutil/trace.go:171","msg":"trace[1506920635] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"192.361068ms","start":"2026-03-19T17:54:22.91119Z","end":"2026-03-19T17:54:23.103551Z","steps":["trace[1506920635] 'process raft request'  (duration: 192.100722ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T17:55:29.816347Z","caller":"traceutil/trace.go:171","msg":"trace[1952481741] linearizableReadLoop","detail":"{readStateIndex:2430; appliedIndex:2429; }","duration":"115.62686ms","start":"2026-03-19T17:55:29.700693Z","end":"2026-03-19T17:55:29.81632Z","steps":["trace[1952481741] 'read index received'  (duration: 115.409355ms)","trace[1952481741] 'applied index is now lower than readState.Index'  (duration: 216.295µs)"],"step_count":2}
{"level":"info","ts":"2026-03-19T17:55:29.816413Z","caller":"traceutil/trace.go:171","msg":"trace[1386799484] transaction","detail":"{read_only:false; response_revision:2334; number_of_response:1; }","duration":"153.046296ms","start":"2026-03-19T17:55:29.663325Z","end":"2026-03-19T17:55:29.816371Z","steps":["trace[1386799484] 'process raft request'  (duration: 152.838512ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T17:55:29.816574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.854276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:524"}
{"level":"info","ts":"2026-03-19T17:55:29.816666Z","caller":"traceutil/trace.go:171","msg":"trace[13812200] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:2334; }","duration":"115.98559ms","start":"2026-03-19T17:55:29.700661Z","end":"2026-03-19T17:55:29.816647Z","steps":["trace[13812200] 'agreement among raft nodes before linearized reading'  (duration: 115.778105ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T17:56:31.902212Z","caller":"traceutil/trace.go:171","msg":"trace[814000531] transaction","detail":"{read_only:false; response_revision:2890; number_of_response:1; }","duration":"106.059106ms","start":"2026-03-19T17:56:31.796123Z","end":"2026-03-19T17:56:31.902183Z","steps":["trace[814000531] 'process raft request'  (duration: 105.706198ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T17:56:37.333737Z","caller":"traceutil/trace.go:171","msg":"trace[383630212] transaction","detail":"{read_only:false; response_revision:2927; number_of_response:1; }","duration":"211.628631ms","start":"2026-03-19T17:56:37.122086Z","end":"2026-03-19T17:56:37.333714Z","steps":["trace[383630212] 'process raft request'  (duration: 211.480418ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T17:57:51.768031Z","caller":"traceutil/trace.go:171","msg":"trace[1309035979] linearizableReadLoop","detail":"{readStateIndex:4238; appliedIndex:4237; }","duration":"102.082141ms","start":"2026-03-19T17:57:51.665921Z","end":"2026-03-19T17:57:51.768004Z","steps":["trace[1309035979] 'read index received'  (duration: 101.901646ms)","trace[1309035979] 'applied index is now lower than readState.Index'  (duration: 179.525µs)"],"step_count":2}
{"level":"info","ts":"2026-03-19T17:57:51.768137Z","caller":"traceutil/trace.go:171","msg":"trace[1209210530] transaction","detail":"{read_only:false; response_revision:4053; number_of_response:1; }","duration":"131.47195ms","start":"2026-03-19T17:57:51.636622Z","end":"2026-03-19T17:57:51.768094Z","steps":["trace[1209210530] 'process raft request'  (duration: 131.222484ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T17:57:51.768255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.303177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"}
{"level":"info","ts":"2026-03-19T17:57:51.768358Z","caller":"traceutil/trace.go:171","msg":"trace[589295422] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4053; }","duration":"102.44888ms","start":"2026-03-19T17:57:51.665888Z","end":"2026-03-19T17:57:51.768337Z","steps":["trace[589295422] 'agreement among raft nodes before linearized reading'  (duration: 102.227864ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T17:57:56.048725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.72287ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3275978433315065048 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:4088 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:474 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-19T17:57:56.049031Z","caller":"traceutil/trace.go:171","msg":"trace[612996860] transaction","detail":"{read_only:false; response_revision:4146; number_of_response:1; }","duration":"137.088903ms","start":"2026-03-19T17:57:55.911912Z","end":"2026-03-19T17:57:56.049001Z","steps":["trace[612996860] 'process raft request'  (duration: 136.949259ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T17:57:56.049128Z","caller":"traceutil/trace.go:171","msg":"trace[34346165] transaction","detail":"{read_only:false; response_revision:4145; number_of_response:1; }","duration":"141.173759ms","start":"2026-03-19T17:57:55.907911Z","end":"2026-03-19T17:57:56.049085Z","steps":["trace[34346165] 'process raft request'  (duration: 17.961758ms)","trace[34346165] 'compare'  (duration: 122.573196ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T17:57:56.164186Z","caller":"traceutil/trace.go:171","msg":"trace[1690871120] transaction","detail":"{read_only:false; response_revision:4148; number_of_response:1; }","duration":"110.014618ms","start":"2026-03-19T17:57:56.054137Z","end":"2026-03-19T17:57:56.164152Z","steps":["trace[1690871120] 'process raft request'  (duration: 107.122099ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T17:58:06.706529Z","caller":"traceutil/trace.go:171","msg":"trace[185282820] linearizableReadLoop","detail":"{readStateIndex:4510; appliedIndex:4509; }","duration":"285.087262ms","start":"2026-03-19T17:58:06.42141Z","end":"2026-03-19T17:58:06.706497Z","steps":["trace[185282820] 'read index received'  (duration: 284.838397ms)","trace[185282820] 'applied index is now lower than readState.Index'  (duration: 247.615µs)"],"step_count":2}
{"level":"info","ts":"2026-03-19T17:58:06.706628Z","caller":"traceutil/trace.go:171","msg":"trace[1141343939] transaction","detail":"{read_only:false; response_revision:4314; number_of_response:1; }","duration":"326.402916ms","start":"2026-03-19T17:58:06.380189Z","end":"2026-03-19T17:58:06.706592Z","steps":["trace[1141343939] 'process raft request'  (duration: 326.127019ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T17:58:06.706948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.496164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"warn","ts":"2026-03-19T17:58:06.707005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.562018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T17:58:06.707098Z","caller":"traceutil/trace.go:171","msg":"trace[61345677] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:4314; }","duration":"133.724642ms","start":"2026-03-19T17:58:06.573355Z","end":"2026-03-19T17:58:06.70708Z","steps":["trace[61345677] 'agreement among raft nodes before linearized reading'  (duration: 133.542198ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T17:58:06.707244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.54888ms","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-03-19T17:58:06.707418Z","caller":"traceutil/trace.go:171","msg":"trace[2090058648] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4314; }","duration":"284.837966ms","start":"2026-03-19T17:58:06.422511Z","end":"2026-03-19T17:58:06.707349Z","steps":["trace[2090058648] 'agreement among raft nodes before linearized reading'  (duration: 284.351565ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T17:58:06.707092Z","caller":"traceutil/trace.go:171","msg":"trace[387948639] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4314; }","duration":"285.738799ms","start":"2026-03-19T17:58:06.421326Z","end":"2026-03-19T17:58:06.707064Z","steps":["trace[387948639] 'agreement among raft nodes before linearized reading'  (duration: 285.332659ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T17:58:06.707262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.941124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-03-19T17:58:06.707659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.894075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-c47d949f5-gxmv7\" ","response":"range_response_count:1 size:7812"}
{"level":"info","ts":"2026-03-19T17:58:06.707791Z","caller":"traceutil/trace.go:171","msg":"trace[1638223311] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-c47d949f5-gxmv7; range_end:; response_count:1; response_revision:4314; }","duration":"160.091749ms","start":"2026-03-19T17:58:06.54767Z","end":"2026-03-19T17:58:06.707761Z","steps":["trace[1638223311] 'agreement among raft nodes before linearized reading'  (duration: 159.642169ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T17:58:06.7077Z","caller":"traceutil/trace.go:171","msg":"trace[939286495] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4314; }","duration":"215.411516ms","start":"2026-03-19T17:58:06.492253Z","end":"2026-03-19T17:58:06.707665Z","steps":["trace[939286495] 'agreement among raft nodes before linearized reading'  (duration: 214.811632ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T17:58:06.707218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.433741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-03-19T17:58:06.708064Z","caller":"traceutil/trace.go:171","msg":"trace[1746819403] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4314; }","duration":"212.379643ms","start":"2026-03-19T17:58:06.495669Z","end":"2026-03-19T17:58:06.708048Z","steps":["trace[1746819403] 'agreement among raft nodes before linearized reading'  (duration: 211.298897ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T17:58:06.706971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T17:58:06.380168Z","time spent":"326.642913ms","remote":"127.0.0.1:53248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:4191 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-03-19T17:58:06.873125Z","caller":"traceutil/trace.go:171","msg":"trace[1441727849] transaction","detail":"{read_only:false; response_revision:4315; number_of_response:1; }","duration":"160.999001ms","start":"2026-03-19T17:58:06.712094Z","end":"2026-03-19T17:58:06.873093Z","steps":["trace[1441727849] 'process raft request'  (duration: 153.776319ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T17:58:06.876136Z","caller":"traceutil/trace.go:171","msg":"trace[1542433004] transaction","detail":"{read_only:false; response_revision:4316; number_of_response:1; }","duration":"163.279914ms","start":"2026-03-19T17:58:06.712831Z","end":"2026-03-19T17:58:06.876111Z","steps":["trace[1542433004] 'process raft request'  (duration: 162.961107ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T17:58:06.876121Z","caller":"traceutil/trace.go:171","msg":"trace[1607752906] transaction","detail":"{read_only:false; response_revision:4317; number_of_response:1; }","duration":"163.178302ms","start":"2026-03-19T17:58:06.712911Z","end":"2026-03-19T17:58:06.876089Z","steps":["trace[1607752906] 'process raft request'  (duration: 163.09181ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T17:58:06.876248Z","caller":"traceutil/trace.go:171","msg":"trace[1193707415] transaction","detail":"{read_only:false; response_revision:4318; number_of_response:1; }","duration":"163.230343ms","start":"2026-03-19T17:58:06.713007Z","end":"2026-03-19T17:58:06.876238Z","steps":["trace[1193707415] 'process raft request'  (duration: 163.042399ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T17:58:06.876493Z","caller":"traceutil/trace.go:171","msg":"trace[1426403947] transaction","detail":"{read_only:false; response_revision:4319; number_of_response:1; }","duration":"163.301976ms","start":"2026-03-19T17:58:06.713179Z","end":"2026-03-19T17:58:06.876481Z","steps":["trace[1426403947] 'process raft request'  (duration: 163.021809ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T17:58:06.876709Z","caller":"traceutil/trace.go:171","msg":"trace[1393247975] transaction","detail":"{read_only:false; response_revision:4320; number_of_response:1; }","duration":"163.46151ms","start":"2026-03-19T17:58:06.713233Z","end":"2026-03-19T17:58:06.876695Z","steps":["trace[1393247975] 'process raft request'  (duration: 163.199683ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T17:58:06.87683Z","caller":"traceutil/trace.go:171","msg":"trace[1007697741] linearizableReadLoop","detail":"{readStateIndex:4518; appliedIndex:4510; }","duration":"107.783086ms","start":"2026-03-19T17:58:06.769033Z","end":"2026-03-19T17:58:06.876816Z","steps":["trace[1007697741] 'read index received'  (duration: 96.809154ms)","trace[1007697741] 'applied index is now lower than readState.Index'  (duration: 10.972852ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T17:58:06.876883Z","caller":"traceutil/trace.go:171","msg":"trace[1440691010] transaction","detail":"{read_only:false; response_revision:4321; number_of_response:1; }","duration":"163.272585ms","start":"2026-03-19T17:58:06.713597Z","end":"2026-03-19T17:58:06.876869Z","steps":["trace[1440691010] 'process raft request'  (duration: 163.05677ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T17:58:06.876865Z","caller":"traceutil/trace.go:171","msg":"trace[46168042] transaction","detail":"{read_only:false; response_revision:4322; number_of_response:1; }","duration":"157.036837ms","start":"2026-03-19T17:58:06.719813Z","end":"2026-03-19T17:58:06.87685Z","steps":["trace[46168042] 'process raft request'  (duration: 156.934584ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T17:58:06.876964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.896469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T17:58:06.877011Z","caller":"traceutil/trace.go:171","msg":"trace[1311631266] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:4322; }","duration":"108.00664ms","start":"2026-03-19T17:58:06.768993Z","end":"2026-03-19T17:58:06.877Z","steps":["trace[1311631266] 'agreement among raft nodes before linearized reading'  (duration: 107.902858ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T17:58:20.521488Z","caller":"traceutil/trace.go:171","msg":"trace[1133414662] transaction","detail":"{read_only:false; response_revision:4566; number_of_response:1; }","duration":"172.987765ms","start":"2026-03-19T17:58:20.348466Z","end":"2026-03-19T17:58:20.521454Z","steps":["trace[1133414662] 'process raft request'  (duration: 150.257214ms)","trace[1133414662] 'compare'  (duration: 22.316871ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T17:58:20.521617Z","caller":"traceutil/trace.go:171","msg":"trace[1538275631] transaction","detail":"{read_only:false; response_revision:4567; number_of_response:1; }","duration":"150.06304ms","start":"2026-03-19T17:58:20.371527Z","end":"2026-03-19T17:58:20.52159Z","steps":["trace[1538275631] 'process raft request'  (duration: 149.767043ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T17:58:24.726643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.270156ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3275978433315066175 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:4607 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:474 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-19T17:58:24.726803Z","caller":"traceutil/trace.go:171","msg":"trace[1630094618] transaction","detail":"{read_only:false; response_revision:4620; number_of_response:1; }","duration":"136.662592ms","start":"2026-03-19T17:58:24.590116Z","end":"2026-03-19T17:58:24.726778Z","steps":["trace[1630094618] 'process raft request'  (duration: 36.13258ms)","trace[1630094618] 'compare'  (duration: 100.087211ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T18:01:47.965453Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2995}
{"level":"info","ts":"2026-03-19T18:01:48.02394Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2995,"took":"56.451071ms","hash":3569974019,"current-db-size-bytes":44253184,"current-db-size":"44 MB","current-db-size-in-use-bytes":33304576,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-03-19T18:01:48.024022Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3569974019,"revision":2995,"compact-revision":-1}
{"level":"info","ts":"2026-03-19T18:04:23.702034Z","caller":"traceutil/trace.go:171","msg":"trace[2072782624] transaction","detail":"{read_only:false; response_revision:7619; number_of_response:1; }","duration":"140.465075ms","start":"2026-03-19T18:04:23.561542Z","end":"2026-03-19T18:04:23.702007Z","steps":["trace[2072782624] 'process raft request'  (duration: 140.338752ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T18:04:23.986835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.099167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T18:04:23.986947Z","caller":"traceutil/trace.go:171","msg":"trace[1766622318] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7619; }","duration":"124.282071ms","start":"2026-03-19T18:04:23.86264Z","end":"2026-03-19T18:04:23.986922Z","steps":["trace[1766622318] 'range keys from in-memory index tree'  (duration: 123.958514ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T18:04:24.5233Z","caller":"traceutil/trace.go:171","msg":"trace[1065041092] transaction","detail":"{read_only:false; response_revision:7620; number_of_response:1; }","duration":"166.585038ms","start":"2026-03-19T18:04:24.356692Z","end":"2026-03-19T18:04:24.523277Z","steps":["trace[1065041092] 'process raft request'  (duration: 166.050165ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T18:04:24.847284Z","caller":"traceutil/trace.go:171","msg":"trace[1903361762] linearizableReadLoop","detail":"{readStateIndex:7985; appliedIndex:7984; }","duration":"286.902052ms","start":"2026-03-19T18:04:24.560352Z","end":"2026-03-19T18:04:24.847254Z","steps":["trace[1903361762] 'read index received'  (duration: 281.535523ms)","trace[1903361762] 'applied index is now lower than readState.Index'  (duration: 5.364719ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T18:04:24.847354Z","caller":"traceutil/trace.go:171","msg":"trace[906729220] transaction","detail":"{read_only:false; response_revision:7622; number_of_response:1; }","duration":"287.20875ms","start":"2026-03-19T18:04:24.560109Z","end":"2026-03-19T18:04:24.847318Z","steps":["trace[906729220] 'process raft request'  (duration: 281.870481ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T18:04:24.84753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.14731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18295"}
{"level":"info","ts":"2026-03-19T18:04:24.847556Z","caller":"traceutil/trace.go:171","msg":"trace[966121495] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:7622; }","duration":"287.208311ms","start":"2026-03-19T18:04:24.560339Z","end":"2026-03-19T18:04:24.847547Z","steps":["trace[966121495] 'agreement among raft nodes before linearized reading'  (duration: 287.010745ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T18:04:51.386515Z","caller":"traceutil/trace.go:171","msg":"trace[1692591253] transaction","detail":"{read_only:false; response_revision:7837; number_of_response:1; }","duration":"240.397205ms","start":"2026-03-19T18:04:51.146095Z","end":"2026-03-19T18:04:51.386493Z","steps":["trace[1692591253] 'process raft request'  (duration: 240.081577ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T18:04:51.567348Z","caller":"traceutil/trace.go:171","msg":"trace[1695429992] transaction","detail":"{read_only:false; response_revision:7838; number_of_response:1; }","duration":"174.360144ms","start":"2026-03-19T18:04:51.392962Z","end":"2026-03-19T18:04:51.567322Z","steps":["trace[1695429992] 'process raft request'  (duration: 174.216811ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T18:04:51.568966Z","caller":"traceutil/trace.go:171","msg":"trace[273080436] transaction","detail":"{read_only:false; response_revision:7839; number_of_response:1; }","duration":"175.87817ms","start":"2026-03-19T18:04:51.393064Z","end":"2026-03-19T18:04:51.568943Z","steps":["trace[273080436] 'process raft request'  (duration: 175.525412ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T18:04:51.569375Z","caller":"traceutil/trace.go:171","msg":"trace[294375834] transaction","detail":"{read_only:false; response_revision:7840; number_of_response:1; }","duration":"176.27568ms","start":"2026-03-19T18:04:51.393082Z","end":"2026-03-19T18:04:51.569358Z","steps":["trace[294375834] 'process raft request'  (duration: 175.616674ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T18:04:51.569591Z","caller":"traceutil/trace.go:171","msg":"trace[461338534] linearizableReadLoop","detail":"{readStateIndex:8218; appliedIndex:8214; }","duration":"172.50983ms","start":"2026-03-19T18:04:51.397066Z","end":"2026-03-19T18:04:51.569576Z","steps":["trace[461338534] 'read index received'  (duration: 170.716897ms)","trace[461338534] 'applied index is now lower than readState.Index'  (duration: 1.791903ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T18:04:51.569636Z","caller":"traceutil/trace.go:171","msg":"trace[1728054835] transaction","detail":"{read_only:false; response_revision:7841; number_of_response:1; }","duration":"175.991544ms","start":"2026-03-19T18:04:51.393628Z","end":"2026-03-19T18:04:51.56962Z","steps":["trace[1728054835] 'process raft request'  (duration: 175.284187ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T18:04:51.569679Z","caller":"traceutil/trace.go:171","msg":"trace[660640502] transaction","detail":"{read_only:false; response_revision:7842; number_of_response:1; }","duration":"175.79327ms","start":"2026-03-19T18:04:51.393855Z","end":"2026-03-19T18:04:51.569648Z","steps":["trace[660640502] 'process raft request'  (duration: 175.670727ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T18:04:51.569807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.714845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:552"}
{"level":"info","ts":"2026-03-19T18:04:51.569856Z","caller":"traceutil/trace.go:171","msg":"trace[2117123441] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7842; }","duration":"172.793757ms","start":"2026-03-19T18:04:51.397049Z","end":"2026-03-19T18:04:51.569842Z","steps":["trace[2117123441] 'agreement among raft nodes before linearized reading'  (duration: 172.626764ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T18:04:51.569995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.138947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"}
{"level":"info","ts":"2026-03-19T18:04:51.57004Z","caller":"traceutil/trace.go:171","msg":"trace[1763071916] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:7842; }","duration":"145.199289ms","start":"2026-03-19T18:04:51.424827Z","end":"2026-03-19T18:04:51.570026Z","steps":["trace[1763071916] 'agreement among raft nodes before linearized reading'  (duration: 145.041955ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T18:04:51.570064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.999823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-03-19T18:04:51.570108Z","caller":"traceutil/trace.go:171","msg":"trace[1812793929] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7842; }","duration":"138.044554ms","start":"2026-03-19T18:04:51.432052Z","end":"2026-03-19T18:04:51.570097Z","steps":["trace[1812793929] 'agreement among raft nodes before linearized reading'  (duration: 137.966943ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T18:05:05.11777Z","caller":"traceutil/trace.go:171","msg":"trace[1686396718] transaction","detail":"{read_only:false; response_revision:7966; number_of_response:1; }","duration":"216.804354ms","start":"2026-03-19T18:05:04.900913Z","end":"2026-03-19T18:05:05.117717Z","steps":["trace[1686396718] 'process raft request'  (duration: 216.539506ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T18:05:06.228764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.157091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11499"}
{"level":"info","ts":"2026-03-19T18:05:06.228904Z","caller":"traceutil/trace.go:171","msg":"trace[1054493055] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:7977; }","duration":"250.357006ms","start":"2026-03-19T18:05:05.978523Z","end":"2026-03-19T18:05:06.22888Z","steps":["trace[1054493055] 'range keys from in-memory index tree'  (duration: 249.859903ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T18:06:47.973454Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6187}
{"level":"info","ts":"2026-03-19T18:06:48.075756Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6187,"took":"99.635643ms","hash":1103819677,"current-db-size-bytes":47009792,"current-db-size":"47 MB","current-db-size-in-use-bytes":23171072,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-03-19T18:06:48.075845Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1103819677,"revision":6187,"compact-revision":2995}
{"level":"info","ts":"2026-03-19T18:07:52.663541Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"11371113779d2d76","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-03-19T18:07:52.67084Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-03-19T18:07:52.671084Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-03-19T18:11:47.978968Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8935}
{"level":"info","ts":"2026-03-19T18:11:48.054357Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8935,"took":"73.292574ms","hash":3093888520,"current-db-size-bytes":47009792,"current-db-size":"47 MB","current-db-size-in-use-bytes":21741568,"current-db-size-in-use":"22 MB"}
{"level":"info","ts":"2026-03-19T18:11:48.054449Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3093888520,"revision":8935,"compact-revision":6187}