{"level":"warn","ts":"2026-03-18T00:47:08.121654Z","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-18T00:47:08.121728Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.70: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://162.253.55.70:2380","--initial-cluster=instance=https://162.253.55.70:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.70:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.70: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-18T00:47:08.121788Z","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-18T00:47:08.121798Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.70:2380"]}
{"level":"info","ts":"2026-03-18T00:47:08.121813Z","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-18T00:47:08.122512Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.70:2379"]}
{"level":"info","ts":"2026-03-18T00:47:08.122588Z","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://162.253.55.70:2380"],"listen-peer-urls":["https://162.253.55.70:2380"],"advertise-client-urls":["https://162.253.55.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.70: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-18T00:47:08.126154Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.367016ms"}
{"level":"info","ts":"2026-03-18T00:47:08.131148Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"23887246632736aa","cluster-id":"62cfeca3ef46d3ef"}
{"level":"info","ts":"2026-03-18T00:47:08.131204Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa switched to configuration voters=()"}
{"level":"info","ts":"2026-03-18T00:47:08.13127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa became follower at term 0"}
{"level":"info","ts":"2026-03-18T00:47:08.131287Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 23887246632736aa [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-18T00:47:08.131294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa became follower at term 1"}
{"level":"info","ts":"2026-03-18T00:47:08.131344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa switched to configuration voters=(2560422034796918442)"}
{"level":"warn","ts":"2026-03-18T00:47:08.137538Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-18T00:47:08.139789Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-18T00:47:08.141076Z","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-18T00:47:08.143915Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"23887246632736aa","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-18T00:47:08.144101Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"23887246632736aa","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-18T00:47:08.144143Z","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-18T00:47:08.144261Z","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-18T00:47:08.144272Z","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-18T00:47:08.145683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa switched to configuration voters=(2560422034796918442)"}
{"level":"info","ts":"2026-03-18T00:47:08.146091Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62cfeca3ef46d3ef","local-member-id":"23887246632736aa","added-peer-id":"23887246632736aa","added-peer-peer-urls":["https://162.253.55.70:2380"]}
{"level":"info","ts":"2026-03-18T00:47:08.148379Z","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-18T00:47:08.148452Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.70:2380"}
{"level":"info","ts":"2026-03-18T00:47:08.148491Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.70:2380"}
{"level":"info","ts":"2026-03-18T00:47:08.148661Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"23887246632736aa","initial-advertise-peer-urls":["https://162.253.55.70:2380"],"listen-peer-urls":["https://162.253.55.70:2380"],"advertise-client-urls":["https://162.253.55.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-18T00:47:08.148716Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-18T00:47:08.534167Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa is starting a new election at term 1"}
{"level":"info","ts":"2026-03-18T00:47:08.534218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-18T00:47:08.534233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa received MsgPreVoteResp from 23887246632736aa at term 1"}
{"level":"info","ts":"2026-03-18T00:47:08.534244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa became candidate at term 2"}
{"level":"info","ts":"2026-03-18T00:47:08.534249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa received MsgVoteResp from 23887246632736aa at term 2"}
{"level":"info","ts":"2026-03-18T00:47:08.534263Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa became leader at term 2"}
{"level":"info","ts":"2026-03-18T00:47:08.53427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 23887246632736aa elected leader 23887246632736aa at term 2"}
{"level":"info","ts":"2026-03-18T00:47:08.542298Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"23887246632736aa","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.70:2379]}","request-path":"/0/members/23887246632736aa/attributes","cluster-id":"62cfeca3ef46d3ef","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-18T00:47:08.542307Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-18T00:47:08.542388Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T00:47:08.54263Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-18T00:47:08.542662Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-18T00:47:08.543131Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62cfeca3ef46d3ef","local-member-id":"23887246632736aa","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T00:47:08.543269Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T00:47:08.543329Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T00:47:08.544562Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-18T00:47:08.54974Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-18T00:47:08.551647Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.70:2379"}
{"level":"warn","ts":"2026-03-18T00:47:25.61537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.56831ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3939133440588211902 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:409 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-18T00:47:25.615507Z","caller":"traceutil/trace.go:171","msg":"trace[137964420] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"442.372077ms","start":"2026-03-18T00:47:25.173116Z","end":"2026-03-18T00:47:25.615488Z","steps":["trace[137964420] 'process raft request'  (duration: 95.081648ms)","trace[137964420] 'compare'  (duration: 346.411367ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:47:25.615586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:47:25.173082Z","time spent":"442.475029ms","remote":"127.0.0.1:46382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:409 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-18T00:47:43.609622Z","caller":"traceutil/trace.go:171","msg":"trace[654359889] linearizableReadLoop","detail":"{readStateIndex:565; appliedIndex:564; }","duration":"292.719975ms","start":"2026-03-18T00:47:43.316875Z","end":"2026-03-18T00:47:43.609595Z","steps":["trace[654359889] 'read index received'  (duration: 292.421617ms)","trace[654359889] 'applied index is now lower than readState.Index'  (duration: 297.258µs)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:47:43.609703Z","caller":"traceutil/trace.go:171","msg":"trace[1607541290] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"474.139848ms","start":"2026-03-18T00:47:43.135525Z","end":"2026-03-18T00:47:43.609665Z","steps":["trace[1607541290] 'process raft request'  (duration: 473.920932ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:47:43.609874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.988412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-03-18T00:47:43.609882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:47:43.1355Z","time spent":"474.287082ms","remote":"127.0.0.1:46292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-t2d72\" mod_revision:499 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-t2d72\" value_size:17081 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-t2d72\" > >"}
{"level":"info","ts":"2026-03-18T00:47:43.609919Z","caller":"traceutil/trace.go:171","msg":"trace[1180079064] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:547; }","duration":"293.109035ms","start":"2026-03-18T00:47:43.316798Z","end":"2026-03-18T00:47:43.609907Z","steps":["trace[1180079064] 'agreement among raft nodes before linearized reading'  (duration: 292.949391ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:47:43.609942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.835428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T00:47:43.610055Z","caller":"traceutil/trace.go:171","msg":"trace[2820791] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:547; }","duration":"170.013182ms","start":"2026-03-18T00:47:43.440017Z","end":"2026-03-18T00:47:43.61003Z","steps":["trace[2820791] 'agreement among raft nodes before linearized reading'  (duration: 169.823737ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:47:44.019902Z","caller":"traceutil/trace.go:171","msg":"trace[215000290] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"324.791175ms","start":"2026-03-18T00:47:43.695086Z","end":"2026-03-18T00:47:44.019877Z","steps":["trace[215000290] 'process raft request'  (duration: 324.61542ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:47:44.020089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:47:43.69505Z","time spent":"324.936787ms","remote":"127.0.0.1:46382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:541 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-18T00:47:44.322929Z","caller":"traceutil/trace.go:171","msg":"trace[594161299] linearizableReadLoop","detail":"{readStateIndex:569; appliedIndex:567; }","duration":"175.866301ms","start":"2026-03-18T00:47:44.147021Z","end":"2026-03-18T00:47:44.322888Z","steps":["trace[594161299] 'read index received'  (duration: 175.683137ms)","trace[594161299] 'applied index is now lower than readState.Index'  (duration: 181.404µs)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:47:44.323151Z","caller":"traceutil/trace.go:171","msg":"trace[1934840499] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"444.762648ms","start":"2026-03-18T00:47:43.878352Z","end":"2026-03-18T00:47:44.323114Z","steps":["trace[1934840499] 'process raft request'  (duration: 444.483851ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:47:44.323287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.257082ms","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-03-18T00:47:44.323272Z","caller":"traceutil/trace.go:171","msg":"trace[1299605213] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"568.498838ms","start":"2026-03-18T00:47:43.754683Z","end":"2026-03-18T00:47:44.323182Z","steps":["trace[1299605213] 'process raft request'  (duration: 568.026816ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:47:44.323341Z","caller":"traceutil/trace.go:171","msg":"trace[1682085189] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:551; }","duration":"176.320603ms","start":"2026-03-18T00:47:44.147006Z","end":"2026-03-18T00:47:44.323326Z","steps":["trace[1682085189] 'agreement among raft nodes before linearized reading'  (duration: 176.17847ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:47:44.323337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:47:43.878315Z","time spent":"444.921542ms","remote":"127.0.0.1:46382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:465 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-03-18T00:47:44.323368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.479393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/cert-manager/\" range_end:\"/registry/secrets/cert-manager0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T00:47:44.323456Z","caller":"traceutil/trace.go:171","msg":"trace[1770156921] range","detail":"{range_begin:/registry/secrets/cert-manager/; range_end:/registry/secrets/cert-manager0; response_count:0; response_revision:551; }","duration":"132.600756ms","start":"2026-03-18T00:47:44.190831Z","end":"2026-03-18T00:47:44.323432Z","steps":["trace[1770156921] 'agreement among raft nodes before linearized reading'  (duration: 132.433572ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:47:44.32351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:47:43.754651Z","time spent":"568.736913ms","remote":"127.0.0.1:46280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4748,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:509 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4714 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-03-18T00:47:45.373302Z","caller":"traceutil/trace.go:171","msg":"trace[1744738558] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"134.913716ms","start":"2026-03-18T00:47:45.238357Z","end":"2026-03-18T00:47:45.37327Z","steps":["trace[1744738558] 'process raft request'  (duration: 38.614346ms)","trace[1744738558] 'compare'  (duration: 96.006402ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:47:45.373352Z","caller":"traceutil/trace.go:171","msg":"trace[1176875328] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"127.520726ms","start":"2026-03-18T00:47:45.245806Z","end":"2026-03-18T00:47:45.373327Z","steps":["trace[1176875328] 'process raft request'  (duration: 127.439464ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:47:45.373494Z","caller":"traceutil/trace.go:171","msg":"trace[862033461] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"133.309723ms","start":"2026-03-18T00:47:45.240148Z","end":"2026-03-18T00:47:45.373458Z","steps":["trace[862033461] 'process raft request'  (duration: 133.004126ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:47:45.382073Z","caller":"traceutil/trace.go:171","msg":"trace[1953905908] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"133.540549ms","start":"2026-03-18T00:47:45.248507Z","end":"2026-03-18T00:47:45.382048Z","steps":["trace[1953905908] 'process raft request'  (duration: 133.401196ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:47:45.382085Z","caller":"traceutil/trace.go:171","msg":"trace[122063184] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"134.234657ms","start":"2026-03-18T00:47:45.247832Z","end":"2026-03-18T00:47:45.382066Z","steps":["trace[122063184] 'process raft request'  (duration: 133.94307ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:47:45.382112Z","caller":"traceutil/trace.go:171","msg":"trace[1613706617] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"129.64782ms","start":"2026-03-18T00:47:45.252445Z","end":"2026-03-18T00:47:45.382093Z","steps":["trace[1613706617] 'process raft request'  (duration: 129.555138ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:47:45.382223Z","caller":"traceutil/trace.go:171","msg":"trace[647819053] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"131.831187ms","start":"2026-03-18T00:47:45.250362Z","end":"2026-03-18T00:47:45.382193Z","steps":["trace[647819053] 'process raft request'  (duration: 131.597181ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:48:55.083612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.834705ms","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-18T00:48:55.083707Z","caller":"traceutil/trace.go:171","msg":"trace[1662582908] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1584; }","duration":"359.977469ms","start":"2026-03-18T00:48:54.723712Z","end":"2026-03-18T00:48:55.083689Z","steps":["trace[1662582908] 'range keys from in-memory index tree'  (duration: 359.66397ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:48:55.083751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:48:54.723691Z","time spent":"360.051731ms","remote":"127.0.0.1:46382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-18T00:48:55.083625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.619652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-18T00:48:55.083825Z","caller":"traceutil/trace.go:171","msg":"trace[1775186269] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1584; }","duration":"351.856999ms","start":"2026-03-18T00:48:54.731954Z","end":"2026-03-18T00:48:55.083811Z","steps":["trace[1775186269] 'range keys from in-memory index tree'  (duration: 351.485059ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:48:55.08386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:48:54.731941Z","time spent":"351.91111ms","remote":"127.0.0.1:46382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-18T00:48:55.530206Z","caller":"traceutil/trace.go:171","msg":"trace[1009482664] transaction","detail":"{read_only:false; response_revision:1589; number_of_response:1; }","duration":"170.351005ms","start":"2026-03-18T00:48:55.359824Z","end":"2026-03-18T00:48:55.530175Z","steps":["trace[1009482664] 'process raft request'  (duration: 170.072508ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:49:08.622196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.55919ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-18T00:49:08.622292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.715507ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3939133440588214383 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1683 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-18T00:49:08.622318Z","caller":"traceutil/trace.go:171","msg":"trace[195249809] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1701; }","duration":"109.692453ms","start":"2026-03-18T00:49:08.512609Z","end":"2026-03-18T00:49:08.622302Z","steps":["trace[195249809] 'range keys from in-memory index tree'  (duration: 109.505369ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:49:08.622429Z","caller":"traceutil/trace.go:171","msg":"trace[1289359885] transaction","detail":"{read_only:false; response_revision:1702; number_of_response:1; }","duration":"221.677314ms","start":"2026-03-18T00:49:08.40072Z","end":"2026-03-18T00:49:08.622397Z","steps":["trace[1289359885] 'process raft request'  (duration: 89.775303ms)","trace[1289359885] 'compare'  (duration: 131.45112ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:49:08.622479Z","caller":"traceutil/trace.go:171","msg":"trace[1707115119] transaction","detail":"{read_only:false; response_revision:1703; number_of_response:1; }","duration":"131.05444ms","start":"2026-03-18T00:49:08.491408Z","end":"2026-03-18T00:49:08.622463Z","steps":["trace[1707115119] 'process raft request'  (duration: 130.981778ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:49:08.62259Z","caller":"traceutil/trace.go:171","msg":"trace[1476688937] linearizableReadLoop","detail":"{readStateIndex:1765; appliedIndex:1764; }","duration":"184.05004ms","start":"2026-03-18T00:49:08.438528Z","end":"2026-03-18T00:49:08.622578Z","steps":["trace[1476688937] 'read index received'  (duration: 51.933653ms)","trace[1476688937] 'applied index is now lower than readState.Index'  (duration: 132.115137ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:49:08.622655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.128341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T00:49:08.622693Z","caller":"traceutil/trace.go:171","msg":"trace[1301725472] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1703; }","duration":"184.185463ms","start":"2026-03-18T00:49:08.438493Z","end":"2026-03-18T00:49:08.622679Z","steps":["trace[1301725472] 'agreement among raft nodes before linearized reading'  (duration: 184.126912ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:49:40.89931Z","caller":"traceutil/trace.go:171","msg":"trace[1878384797] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"167.420493ms","start":"2026-03-18T00:49:40.731852Z","end":"2026-03-18T00:49:40.899272Z","steps":["trace[1878384797] 'process raft request'  (duration: 167.086714ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:49:41.102059Z","caller":"traceutil/trace.go:171","msg":"trace[1346050237] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"197.180996ms","start":"2026-03-18T00:49:40.904845Z","end":"2026-03-18T00:49:41.102026Z","steps":["trace[1346050237] 'process raft request'  (duration: 148.223821ms)","trace[1346050237] 'compare'  (duration: 48.638347ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:50:35.199018Z","caller":"traceutil/trace.go:171","msg":"trace[867377085] transaction","detail":"{read_only:false; response_revision:2308; number_of_response:1; }","duration":"106.371033ms","start":"2026-03-18T00:50:35.09262Z","end":"2026-03-18T00:50:35.198991Z","steps":["trace[867377085] 'process raft request'  (duration: 106.057315ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:51:08.574687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.261854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T00:51:08.574792Z","caller":"traceutil/trace.go:171","msg":"trace[215916105] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2493; }","duration":"135.420558ms","start":"2026-03-18T00:51:08.439353Z","end":"2026-03-18T00:51:08.574774Z","steps":["trace[215916105] 'range keys from in-memory index tree'  (duration: 135.169642ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:51:08.920379Z","caller":"traceutil/trace.go:171","msg":"trace[577542651] transaction","detail":"{read_only:false; response_revision:2494; number_of_response:1; }","duration":"102.914214ms","start":"2026-03-18T00:51:08.817446Z","end":"2026-03-18T00:51:08.92036Z","steps":["trace[577542651] 'process raft request'  (duration: 102.790381ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:51:09.124122Z","caller":"traceutil/trace.go:171","msg":"trace[631840784] transaction","detail":"{read_only:false; response_revision:2495; number_of_response:1; }","duration":"303.316053ms","start":"2026-03-18T00:51:08.820769Z","end":"2026-03-18T00:51:09.124085Z","steps":["trace[631840784] 'process raft request'  (duration: 272.056761ms)","trace[631840784] 'compare'  (duration: 31.012756ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:51:09.124295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:51:08.820752Z","time spent":"303.457526ms","remote":"127.0.0.1:46382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:2485 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-18T00:54:59.548002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.60261ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3939133440588221374 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/monitoring/vector-lxncm\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/monitoring/vector-lxncm\" value_size:4842 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-18T00:54:59.548182Z","caller":"traceutil/trace.go:171","msg":"trace[1961210412] linearizableReadLoop","detail":"{readStateIndex:4704; appliedIndex:4703; }","duration":"394.128947ms","start":"2026-03-18T00:54:59.154029Z","end":"2026-03-18T00:54:59.548158Z","steps":["trace[1961210412] 'read index received'  (duration: 69.22981ms)","trace[1961210412] 'applied index is now lower than readState.Index'  (duration: 324.894257ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:54:59.548311Z","caller":"traceutil/trace.go:171","msg":"trace[1671463163] transaction","detail":"{read_only:false; response_revision:4528; number_of_response:1; }","duration":"480.289363ms","start":"2026-03-18T00:54:59.068006Z","end":"2026-03-18T00:54:59.548296Z","steps":["trace[1671463163] 'process raft request'  (duration: 155.263914ms)","trace[1671463163] 'compare'  (duration: 324.324711ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:54:59.548387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:54:59.06797Z","time spent":"480.386466ms","remote":"127.0.0.1:46292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4888,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/monitoring/vector-lxncm\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/monitoring/vector-lxncm\" value_size:4842 >> failure:<>"}
{"level":"warn","ts":"2026-03-18T00:54:59.548553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.033731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d34264b5-d936-4faa-afa7-284de091c59f\" ","response":"range_response_count:1 size:3600"}
{"level":"info","ts":"2026-03-18T00:54:59.548636Z","caller":"traceutil/trace.go:171","msg":"trace[1004301828] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d34264b5-d936-4faa-afa7-284de091c59f; range_end:; response_count:1; response_revision:4528; }","duration":"271.191566ms","start":"2026-03-18T00:54:59.277425Z","end":"2026-03-18T00:54:59.548617Z","steps":["trace[1004301828] 'agreement among raft nodes before linearized reading'  (duration: 270.918019ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:54:59.548667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.946264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-18T00:54:59.548709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.244992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d34264b5-d936-4faa-afa7-284de091c59f\" ","response":"range_response_count:1 size:3600"}
{"level":"info","ts":"2026-03-18T00:54:59.548762Z","caller":"traceutil/trace.go:171","msg":"trace[1952097955] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4528; }","duration":"111.097578ms","start":"2026-03-18T00:54:59.43764Z","end":"2026-03-18T00:54:59.548738Z","steps":["trace[1952097955] 'agreement among raft nodes before linearized reading'  (duration: 110.945405ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:54:59.548774Z","caller":"traceutil/trace.go:171","msg":"trace[847653622] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d34264b5-d936-4faa-afa7-284de091c59f; range_end:; response_count:1; response_revision:4528; }","duration":"174.371746ms","start":"2026-03-18T00:54:59.37438Z","end":"2026-03-18T00:54:59.548752Z","steps":["trace[847653622] 'agreement among raft nodes before linearized reading'  (duration: 174.203051ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:54:59.548817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.172606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-mgzv7-tls\" ","response":"range_response_count:1 size:2183"}
{"level":"info","ts":"2026-03-18T00:54:59.548905Z","caller":"traceutil/trace.go:171","msg":"trace[823177764] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-mgzv7-tls; range_end:; response_count:1; response_revision:4528; }","duration":"135.29601ms","start":"2026-03-18T00:54:59.413586Z","end":"2026-03-18T00:54:59.548882Z","steps":["trace[823177764] 'agreement among raft nodes before linearized reading'  (duration: 134.995262ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:54:59.549318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.284848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:777446"}
{"level":"info","ts":"2026-03-18T00:54:59.5495Z","caller":"traceutil/trace.go:171","msg":"trace[1534447152] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:4528; }","duration":"395.465932ms","start":"2026-03-18T00:54:59.154015Z","end":"2026-03-18T00:54:59.549481Z","steps":["trace[1534447152] 'agreement among raft nodes before linearized reading'  (duration: 394.310162ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:54:59.549615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:54:59.153993Z","time spent":"395.607025ms","remote":"127.0.0.1:46190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":25,"response size":777468,"request content":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" "}
{"level":"info","ts":"2026-03-18T00:55:07.711925Z","caller":"traceutil/trace.go:171","msg":"trace[385837692] transaction","detail":"{read_only:false; response_revision:4689; number_of_response:1; }","duration":"134.237093ms","start":"2026-03-18T00:55:07.577653Z","end":"2026-03-18T00:55:07.71189Z","steps":["trace[385837692] 'process raft request'  (duration: 130.2517ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:55:07.720286Z","caller":"traceutil/trace.go:171","msg":"trace[3964505] transaction","detail":"{read_only:false; response_revision:4690; number_of_response:1; }","duration":"141.598082ms","start":"2026-03-18T00:55:07.578653Z","end":"2026-03-18T00:55:07.720251Z","steps":["trace[3964505] 'process raft request'  (duration: 141.249094ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:55:07.720344Z","caller":"traceutil/trace.go:171","msg":"trace[667594014] transaction","detail":"{read_only:false; response_revision:4691; number_of_response:1; }","duration":"140.868413ms","start":"2026-03-18T00:55:07.579424Z","end":"2026-03-18T00:55:07.720293Z","steps":["trace[667594014] 'process raft request'  (duration: 140.694059ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:55:07.720273Z","caller":"traceutil/trace.go:171","msg":"trace[1880315188] linearizableReadLoop","detail":"{readStateIndex:4871; appliedIndex:4869; }","duration":"141.176042ms","start":"2026-03-18T00:55:07.579053Z","end":"2026-03-18T00:55:07.720229Z","steps":["trace[1880315188] 'read index received'  (duration: 128.871345ms)","trace[1880315188] 'applied index is now lower than readState.Index'  (duration: 12.303667ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:55:07.720385Z","caller":"traceutil/trace.go:171","msg":"trace[1728799445] transaction","detail":"{read_only:false; response_revision:4692; number_of_response:1; }","duration":"140.684619ms","start":"2026-03-18T00:55:07.57967Z","end":"2026-03-18T00:55:07.720354Z","steps":["trace[1728799445] 'process raft request'  (duration: 140.516395ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:55:07.720765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.680915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"}
{"level":"info","ts":"2026-03-18T00:55:07.720909Z","caller":"traceutil/trace.go:171","msg":"trace[2104544572] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4692; }","duration":"141.842659ms","start":"2026-03-18T00:55:07.57904Z","end":"2026-03-18T00:55:07.720882Z","steps":["trace[2104544572] 'agreement among raft nodes before linearized reading'  (duration: 141.304904ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:55:09.60063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.992741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-rwgbw\" ","response":"range_response_count:1 size:7817"}
{"level":"info","ts":"2026-03-18T00:55:09.600788Z","caller":"traceutil/trace.go:171","msg":"trace[1219084729] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-rwgbw; range_end:; response_count:1; response_revision:4734; }","duration":"119.216066ms","start":"2026-03-18T00:55:09.481548Z","end":"2026-03-18T00:55:09.600764Z","steps":["trace[1219084729] 'range keys from in-memory index tree'  (duration: 118.763535ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:55:17.642503Z","caller":"traceutil/trace.go:171","msg":"trace[202826433] transaction","detail":"{read_only:false; response_revision:4894; number_of_response:1; }","duration":"126.997977ms","start":"2026-03-18T00:55:17.51547Z","end":"2026-03-18T00:55:17.642468Z","steps":["trace[202826433] 'process raft request'  (duration: 126.78461ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:55:17.86421Z","caller":"traceutil/trace.go:171","msg":"trace[142542009] linearizableReadLoop","detail":"{readStateIndex:5079; appliedIndex:5078; }","duration":"102.224709ms","start":"2026-03-18T00:55:17.761936Z","end":"2026-03-18T00:55:17.864161Z","steps":["trace[142542009] 'read index received'  (duration: 68.696677ms)","trace[142542009] 'applied index is now lower than readState.Index'  (duration: 33.526112ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:55:17.864277Z","caller":"traceutil/trace.go:171","msg":"trace[854086089] transaction","detail":"{read_only:false; response_revision:4895; number_of_response:1; }","duration":"212.217078ms","start":"2026-03-18T00:55:17.651991Z","end":"2026-03-18T00:55:17.864208Z","steps":["trace[854086089] 'process raft request'  (duration: 178.631214ms)","trace[854086089] 'compare'  (duration: 33.249236ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:55:17.864505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.537048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-26110ece-6d0a-4a30-95cc-eef32dae9b2e\" ","response":"range_response_count:1 size:3645"}
{"level":"info","ts":"2026-03-18T00:55:17.864628Z","caller":"traceutil/trace.go:171","msg":"trace[1423461164] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-26110ece-6d0a-4a30-95cc-eef32dae9b2e; range_end:; response_count:1; response_revision:4895; }","duration":"102.726163ms","start":"2026-03-18T00:55:17.761873Z","end":"2026-03-18T00:55:17.864599Z","steps":["trace[1423461164] 'agreement among raft nodes before linearized reading'  (duration: 102.423945ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:55:18.034322Z","caller":"traceutil/trace.go:171","msg":"trace[1076924051] transaction","detail":"{read_only:false; response_revision:4897; number_of_response:1; }","duration":"162.316905ms","start":"2026-03-18T00:55:17.87196Z","end":"2026-03-18T00:55:18.034277Z","steps":["trace[1076924051] 'process raft request'  (duration: 151.256291ms)","trace[1076924051] 'compare'  (duration: 10.865729ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:55:18.034834Z","caller":"traceutil/trace.go:171","msg":"trace[1262057317] transaction","detail":"{read_only:false; response_revision:4898; number_of_response:1; }","duration":"162.752466ms","start":"2026-03-18T00:55:17.87202Z","end":"2026-03-18T00:55:18.034772Z","steps":["trace[1262057317] 'process raft request'  (duration: 162.232752ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:55:18.034912Z","caller":"traceutil/trace.go:171","msg":"trace[1469178183] transaction","detail":"{read_only:false; response_revision:4899; number_of_response:1; }","duration":"162.815997ms","start":"2026-03-18T00:55:17.872057Z","end":"2026-03-18T00:55:18.034873Z","steps":["trace[1469178183] 'process raft request'  (duration: 162.465119ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:55:18.03512Z","caller":"traceutil/trace.go:171","msg":"trace[703156192] transaction","detail":"{read_only:false; response_revision:4901; number_of_response:1; }","duration":"162.776246ms","start":"2026-03-18T00:55:17.872305Z","end":"2026-03-18T00:55:18.035081Z","steps":["trace[703156192] 'process raft request'  (duration: 162.378797ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:55:18.035176Z","caller":"traceutil/trace.go:171","msg":"trace[1248937608] transaction","detail":"{read_only:false; response_revision:4902; number_of_response:1; }","duration":"161.254759ms","start":"2026-03-18T00:55:17.873895Z","end":"2026-03-18T00:55:18.03515Z","steps":["trace[1248937608] 'process raft request'  (duration: 160.890139ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:55:18.035214Z","caller":"traceutil/trace.go:171","msg":"trace[688668442] transaction","detail":"{read_only:false; response_revision:4903; number_of_response:1; }","duration":"159.231086ms","start":"2026-03-18T00:55:17.87596Z","end":"2026-03-18T00:55:18.035191Z","steps":["trace[688668442] 'process raft request'  (duration: 158.987559ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:55:18.036107Z","caller":"traceutil/trace.go:171","msg":"trace[490842861] transaction","detail":"{read_only:false; response_revision:4900; number_of_response:1; }","duration":"163.765622ms","start":"2026-03-18T00:55:17.872306Z","end":"2026-03-18T00:55:18.036072Z","steps":["trace[490842861] 'process raft request'  (duration: 162.297565ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:55:18.324432Z","caller":"traceutil/trace.go:171","msg":"trace[245888247] transaction","detail":"{read_only:false; response_revision:4911; number_of_response:1; }","duration":"250.218006ms","start":"2026-03-18T00:55:18.074178Z","end":"2026-03-18T00:55:18.324396Z","steps":["trace[245888247] 'process raft request'  (duration: 250.128024ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:55:18.324642Z","caller":"traceutil/trace.go:171","msg":"trace[2126968977] transaction","detail":"{read_only:false; response_revision:4910; number_of_response:1; }","duration":"252.450383ms","start":"2026-03-18T00:55:18.072159Z","end":"2026-03-18T00:55:18.324609Z","steps":["trace[2126968977] 'process raft request'  (duration: 252.063713ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:55:18.324766Z","caller":"traceutil/trace.go:171","msg":"trace[1711826944] transaction","detail":"{read_only:false; response_revision:4909; number_of_response:1; }","duration":"254.595748ms","start":"2026-03-18T00:55:18.070114Z","end":"2026-03-18T00:55:18.32471Z","steps":["trace[1711826944] 'process raft request'  (duration: 254.030043ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:55:18.324942Z","caller":"traceutil/trace.go:171","msg":"trace[1547376899] transaction","detail":"{read_only:false; response_revision:4907; number_of_response:1; }","duration":"255.298066ms","start":"2026-03-18T00:55:18.069572Z","end":"2026-03-18T00:55:18.32487Z","steps":["trace[1547376899] 'process raft request'  (duration: 254.458914ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:55:18.325118Z","caller":"traceutil/trace.go:171","msg":"trace[914177493] transaction","detail":"{read_only:false; response_revision:4906; number_of_response:1; }","duration":"255.919661ms","start":"2026-03-18T00:55:18.06894Z","end":"2026-03-18T00:55:18.32486Z","steps":["trace[914177493] 'process raft request'  (duration: 186.516257ms)","trace[914177493] 'compare'  (duration: 68.402929ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:55:18.324519Z","caller":"traceutil/trace.go:171","msg":"trace[1759929382] transaction","detail":"{read_only:false; response_revision:4908; number_of_response:1; }","duration":"254.64991ms","start":"2026-03-18T00:55:18.069824Z","end":"2026-03-18T00:55:18.324474Z","steps":["trace[1759929382] 'process raft request'  (duration: 254.27296ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:55:18.327271Z","caller":"traceutil/trace.go:171","msg":"trace[1517502322] linearizableReadLoop","detail":"{readStateIndex:5096; appliedIndex:5089; }","duration":"109.956198ms","start":"2026-03-18T00:55:18.217268Z","end":"2026-03-18T00:55:18.327224Z","steps":["trace[1517502322] 'read index received'  (duration: 38.170951ms)","trace[1517502322] 'applied index is now lower than readState.Index'  (duration: 71.783877ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:55:18.327481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.202694ms","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-18T00:55:18.327524Z","caller":"traceutil/trace.go:171","msg":"trace[856271828] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4912; }","duration":"110.342517ms","start":"2026-03-18T00:55:18.21717Z","end":"2026-03-18T00:55:18.327512Z","steps":["trace[856271828] 'agreement among raft nodes before linearized reading'  (duration: 110.158263ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:55:18.327615Z","caller":"traceutil/trace.go:171","msg":"trace[1783183848] transaction","detail":"{read_only:false; response_revision:4912; number_of_response:1; }","duration":"157.958832ms","start":"2026-03-18T00:55:18.169599Z","end":"2026-03-18T00:55:18.327558Z","steps":["trace[1783183848] 'process raft request'  (duration: 157.534422ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:55:28.448697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.740112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-18T00:55:28.448805Z","caller":"traceutil/trace.go:171","msg":"trace[616540606] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:5047; }","duration":"119.4334ms","start":"2026-03-18T00:55:28.329351Z","end":"2026-03-18T00:55:28.448784Z","steps":["trace[616540606] 'count revisions from in-memory index tree'  (duration: 118.572668ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:55:59.05962Z","caller":"traceutil/trace.go:171","msg":"trace[1733022901] transaction","detail":"{read_only:false; response_revision:5334; number_of_response:1; }","duration":"100.861831ms","start":"2026-03-18T00:55:58.958725Z","end":"2026-03-18T00:55:59.059587Z","steps":["trace[1733022901] 'process raft request'  (duration: 100.629845ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:56:06.78876Z","caller":"traceutil/trace.go:171","msg":"trace[845290050] transaction","detail":"{read_only:false; response_revision:5377; number_of_response:1; }","duration":"100.82412ms","start":"2026-03-18T00:56:06.687904Z","end":"2026-03-18T00:56:06.788728Z","steps":["trace[845290050] 'process raft request'  (duration: 100.640545ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:56:06.83074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.6505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-hmxqm\" ","response":"range_response_count:1 size:6527"}
{"level":"info","ts":"2026-03-18T00:56:06.830833Z","caller":"traceutil/trace.go:171","msg":"trace[1269016748] range","detail":"{range_begin:/registry/pods/openstack/keepalived-hmxqm; range_end:; response_count:1; response_revision:5379; }","duration":"137.798864ms","start":"2026-03-18T00:56:06.693012Z","end":"2026-03-18T00:56:06.830811Z","steps":["trace[1269016748] 'agreement among raft nodes before linearized reading'  (duration: 137.600369ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:56:07.190595Z","caller":"traceutil/trace.go:171","msg":"trace[964213307] transaction","detail":"{read_only:false; response_revision:5380; number_of_response:1; }","duration":"198.52348ms","start":"2026-03-18T00:56:06.992024Z","end":"2026-03-18T00:56:07.190548Z","steps":["trace[964213307] 'process raft request'  (duration: 198.247433ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:56:07.381888Z","caller":"traceutil/trace.go:171","msg":"trace[320941870] transaction","detail":"{read_only:false; response_revision:5382; number_of_response:1; }","duration":"143.034159ms","start":"2026-03-18T00:56:07.238817Z","end":"2026-03-18T00:56:07.381851Z","steps":["trace[320941870] 'process raft request'  (duration: 126.81109ms)","trace[320941870] 'compare'  (duration: 15.969212ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:56:07.381996Z","caller":"traceutil/trace.go:171","msg":"trace[511524493] transaction","detail":"{read_only:false; response_revision:5383; number_of_response:1; }","duration":"143.132653ms","start":"2026-03-18T00:56:07.238837Z","end":"2026-03-18T00:56:07.38197Z","steps":["trace[511524493] 'process raft request'  (duration: 142.959117ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:57:08.576797Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2789}
{"level":"info","ts":"2026-03-18T00:57:08.639933Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2789,"took":"61.64363ms","hash":1756664117,"current-db-size-bytes":42176512,"current-db-size":"42 MB","current-db-size-in-use-bytes":31956992,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-03-18T00:57:08.639996Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1756664117,"revision":2789,"compact-revision":-1}
{"level":"info","ts":"2026-03-18T01:01:08.987189Z","caller":"traceutil/trace.go:171","msg":"trace[884037029] transaction","detail":"{read_only:false; response_revision:7490; number_of_response:1; }","duration":"155.012675ms","start":"2026-03-18T01:01:08.832148Z","end":"2026-03-18T01:01:08.987161Z","steps":["trace[884037029] 'process raft request'  (duration: 154.79586ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:01:08.987447Z","caller":"traceutil/trace.go:171","msg":"trace[799017829] transaction","detail":"{read_only:false; response_revision:7491; number_of_response:1; }","duration":"154.327569ms","start":"2026-03-18T01:01:08.833097Z","end":"2026-03-18T01:01:08.987425Z","steps":["trace[799017829] 'process raft request'  (duration: 154.023041ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:01:20.2723Z","caller":"traceutil/trace.go:171","msg":"trace[1052520313] transaction","detail":"{read_only:false; response_revision:7540; number_of_response:1; }","duration":"453.792528ms","start":"2026-03-18T01:01:19.818481Z","end":"2026-03-18T01:01:20.272274Z","steps":["trace[1052520313] 'process raft request'  (duration: 453.633074ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:01:20.272459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T01:01:19.818454Z","time spent":"453.924952ms","remote":"127.0.0.1:46382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:7529 > 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-03-18T01:01:20.285307Z","caller":"traceutil/trace.go:171","msg":"trace[1922608440] linearizableReadLoop","detail":"{readStateIndex:7816; appliedIndex:7814; }","duration":"339.575317ms","start":"2026-03-18T01:01:19.94572Z","end":"2026-03-18T01:01:20.285295Z","steps":["trace[1922608440] 'read index received'  (duration: 326.4385ms)","trace[1922608440] 'applied index is now lower than readState.Index'  (duration: 13.136137ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T01:01:20.285403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.675579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T01:01:20.285399Z","caller":"traceutil/trace.go:171","msg":"trace[1605552450] transaction","detail":"{read_only:false; response_revision:7541; number_of_response:1; }","duration":"385.515598ms","start":"2026-03-18T01:01:19.899843Z","end":"2026-03-18T01:01:20.285359Z","steps":["trace[1605552450] 'process raft request'  (duration: 385.392865ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:01:20.285433Z","caller":"traceutil/trace.go:171","msg":"trace[1252699503] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:7541; }","duration":"339.737201ms","start":"2026-03-18T01:01:19.945688Z","end":"2026-03-18T01:01:20.285425Z","steps":["trace[1252699503] 'agreement among raft nodes before linearized reading'  (duration: 339.68241ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:01:20.285602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T01:01:19.899825Z","time spent":"385.652553ms","remote":"127.0.0.1:46382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:7530 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-03-18T01:01:20.285614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T01:01:19.945671Z","time spent":"339.933336ms","remote":"127.0.0.1:46508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":27,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "}
{"level":"warn","ts":"2026-03-18T01:01:20.285769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.95744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-03-18T01:01:20.285866Z","caller":"traceutil/trace.go:171","msg":"trace[1344180157] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7541; }","duration":"273.179955ms","start":"2026-03-18T01:01:20.012661Z","end":"2026-03-18T01:01:20.285841Z","steps":["trace[1344180157] 'agreement among raft nodes before linearized reading'  (duration: 272.824175ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:01:21.318343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.402935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-18T01:01:21.318415Z","caller":"traceutil/trace.go:171","msg":"trace[132010413] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7545; }","duration":"276.514238ms","start":"2026-03-18T01:01:21.041885Z","end":"2026-03-18T01:01:21.318399Z","steps":["trace[132010413] 'range keys from in-memory index tree'  (duration: 276.250312ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:01:21.318449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.844657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-03-18T01:01:21.318476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.266734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-18T01:01:21.318527Z","caller":"traceutil/trace.go:171","msg":"trace[1063787887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7545; }","duration":"270.983701ms","start":"2026-03-18T01:01:21.047525Z","end":"2026-03-18T01:01:21.318509Z","steps":["trace[1063787887] 'range keys from in-memory index tree'  (duration: 270.664353ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:01:21.318533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.88165ms","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-18T01:01:21.318617Z","caller":"traceutil/trace.go:171","msg":"trace[2125727096] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7545; }","duration":"339.014092ms","start":"2026-03-18T01:01:20.979585Z","end":"2026-03-18T01:01:21.3186Z","steps":["trace[2125727096] 'range keys from in-memory index tree'  (duration: 338.703065ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:01:21.318669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T01:01:20.979563Z","time spent":"339.093734ms","remote":"127.0.0.1:46382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-18T01:01:21.31855Z","caller":"traceutil/trace.go:171","msg":"trace[1774383135] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:7545; }","duration":"299.355866ms","start":"2026-03-18T01:01:21.019176Z","end":"2026-03-18T01:01:21.318532Z","steps":["trace[1774383135] 'count revisions from in-memory index tree'  (duration: 299.097489ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:01:21.318771Z","caller":"traceutil/trace.go:171","msg":"trace[794425245] transaction","detail":"{read_only:false; response_revision:7546; number_of_response:1; }","duration":"203.787749ms","start":"2026-03-18T01:01:21.114956Z","end":"2026-03-18T01:01:21.318744Z","steps":["trace[794425245] 'process raft request'  (duration: 194.344515ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:01:21.471904Z","caller":"traceutil/trace.go:171","msg":"trace[837981366] transaction","detail":"{read_only:false; response_revision:7548; number_of_response:1; }","duration":"148.659468ms","start":"2026-03-18T01:01:21.323215Z","end":"2026-03-18T01:01:21.471875Z","steps":["trace[837981366] 'process raft request'  (duration: 96.167232ms)","trace[837981366] 'compare'  (duration: 52.280151ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T01:01:21.472099Z","caller":"traceutil/trace.go:171","msg":"trace[1766386751] transaction","detail":"{read_only:false; response_revision:7549; number_of_response:1; }","duration":"148.841961ms","start":"2026-03-18T01:01:21.323226Z","end":"2026-03-18T01:01:21.472068Z","steps":["trace[1766386751] 'process raft request'  (duration: 148.604856ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:01:21.619872Z","caller":"traceutil/trace.go:171","msg":"trace[772653496] transaction","detail":"{read_only:false; response_revision:7551; number_of_response:1; }","duration":"101.381251ms","start":"2026-03-18T01:01:21.518454Z","end":"2026-03-18T01:01:21.619835Z","steps":["trace[772653496] 'process raft request'  (duration: 65.419777ms)","trace[772653496] 'compare'  (duration: 35.701508ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T01:01:22.460666Z","caller":"traceutil/trace.go:171","msg":"trace[598714990] linearizableReadLoop","detail":"{readStateIndex:7829; appliedIndex:7827; }","duration":"148.670948ms","start":"2026-03-18T01:01:22.311969Z","end":"2026-03-18T01:01:22.46064Z","steps":["trace[598714990] 'read index received'  (duration: 8.768388ms)","trace[598714990] 'applied index is now lower than readState.Index'  (duration: 139.90147ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T01:01:22.460825Z","caller":"traceutil/trace.go:171","msg":"trace[772701801] transaction","detail":"{read_only:false; response_revision:7553; number_of_response:1; }","duration":"170.282986ms","start":"2026-03-18T01:01:22.290408Z","end":"2026-03-18T01:01:22.460691Z","steps":["trace[772701801] 'process raft request'  (duration: 170.086271ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:01:22.460909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.914774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-03-18T01:01:22.460978Z","caller":"traceutil/trace.go:171","msg":"trace[1516683921] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7553; }","duration":"149.035997ms","start":"2026-03-18T01:01:22.311925Z","end":"2026-03-18T01:01:22.460961Z","steps":["trace[1516683921] 'agreement among raft nodes before linearized reading'  (duration: 148.799621ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:01:22.574005Z","caller":"traceutil/trace.go:171","msg":"trace[955320982] transaction","detail":"{read_only:false; response_revision:7554; number_of_response:1; }","duration":"108.624922ms","start":"2026-03-18T01:01:22.465355Z","end":"2026-03-18T01:01:22.57398Z","steps":["trace[955320982] 'process raft request'  (duration: 73.825116ms)","trace[955320982] 'compare'  (duration: 34.639152ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T01:01:22.574232Z","caller":"traceutil/trace.go:171","msg":"trace[336989046] transaction","detail":"{read_only:false; response_revision:7555; number_of_response:1; }","duration":"108.271663ms","start":"2026-03-18T01:01:22.465926Z","end":"2026-03-18T01:01:22.574198Z","steps":["trace[336989046] 'process raft request'  (duration: 108.012156ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:01:22.574315Z","caller":"traceutil/trace.go:171","msg":"trace[1998658078] transaction","detail":"{read_only:false; response_revision:7556; number_of_response:1; }","duration":"107.841893ms","start":"2026-03-18T01:01:22.46641Z","end":"2026-03-18T01:01:22.574252Z","steps":["trace[1998658078] 'process raft request'  (duration: 107.687608ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:01:49.598719Z","caller":"traceutil/trace.go:171","msg":"trace[1784009420] transaction","detail":"{read_only:false; response_revision:7738; number_of_response:1; }","duration":"124.58042ms","start":"2026-03-18T01:01:49.474111Z","end":"2026-03-18T01:01:49.598692Z","steps":["trace[1784009420] 'process raft request'  (duration: 124.332463ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:01:50.670306Z","caller":"traceutil/trace.go:171","msg":"trace[138704825] transaction","detail":"{read_only:false; response_revision:7742; number_of_response:1; }","duration":"114.339644ms","start":"2026-03-18T01:01:50.555939Z","end":"2026-03-18T01:01:50.670278Z","steps":["trace[138704825] 'process raft request'  (duration: 114.14551ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:02:01.455776Z","caller":"traceutil/trace.go:171","msg":"trace[1999531248] transaction","detail":"{read_only:false; number_of_response:1; response_revision:7835; }","duration":"145.537388ms","start":"2026-03-18T01:02:01.310215Z","end":"2026-03-18T01:02:01.455752Z","steps":["trace[1999531248] 'process raft request'  (duration: 145.473117ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:02:01.455973Z","caller":"traceutil/trace.go:171","msg":"trace[1900160001] transaction","detail":"{read_only:false; response_revision:7834; number_of_response:1; }","duration":"145.949218ms","start":"2026-03-18T01:02:01.309993Z","end":"2026-03-18T01:02:01.455943Z","steps":["trace[1900160001] 'process raft request'  (duration: 68.53448ms)","trace[1900160001] 'compare'  (duration: 77.012709ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T01:02:01.643023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.336303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-b5958cc86-mngwb.189dc9bfe99c3f41\" ","response":"range_response_count:1 size:1131"}
{"level":"info","ts":"2026-03-18T01:02:01.643182Z","caller":"traceutil/trace.go:171","msg":"trace[1997363518] range","detail":"{range_begin:/registry/events/openstack/barbican-api-b5958cc86-mngwb.189dc9bfe99c3f41; range_end:; response_count:1; response_revision:7835; }","duration":"156.543028ms","start":"2026-03-18T01:02:01.486624Z","end":"2026-03-18T01:02:01.643167Z","steps":["trace[1997363518] 'agreement among raft nodes before linearized reading'  (duration: 156.2504ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:02:01.642287Z","caller":"traceutil/trace.go:171","msg":"trace[2099292678] linearizableReadLoop","detail":"{readStateIndex:8124; appliedIndex:8123; }","duration":"155.580315ms","start":"2026-03-18T01:02:01.486671Z","end":"2026-03-18T01:02:01.642251Z","steps":["trace[2099292678] 'read index received'  (duration: 87.110636ms)","trace[2099292678] 'applied index is now lower than readState.Index'  (duration: 68.468059ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T01:02:02.215889Z","caller":"traceutil/trace.go:171","msg":"trace[646233753] linearizableReadLoop","detail":"{readStateIndex:8132; appliedIndex:8131; }","duration":"115.636965ms","start":"2026-03-18T01:02:02.100228Z","end":"2026-03-18T01:02:02.215865Z","steps":["trace[646233753] 'read index received'  (duration: 115.478202ms)","trace[646233753] 'applied index is now lower than readState.Index'  (duration: 157.533µs)"],"step_count":2}
{"level":"info","ts":"2026-03-18T01:02:02.215949Z","caller":"traceutil/trace.go:171","msg":"trace[272302430] transaction","detail":"{read_only:false; response_revision:7843; number_of_response:1; }","duration":"122.268147ms","start":"2026-03-18T01:02:02.093646Z","end":"2026-03-18T01:02:02.215914Z","steps":["trace[272302430] 'process raft request'  (duration: 122.063093ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:02:02.216139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.897551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-03-18T01:02:02.216207Z","caller":"traceutil/trace.go:171","msg":"trace[155596023] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:7843; }","duration":"116.020634ms","start":"2026-03-18T01:02:02.100167Z","end":"2026-03-18T01:02:02.216188Z","steps":["trace[155596023] 'agreement among raft nodes before linearized reading'  (duration: 115.828219ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:02:02.405031Z","caller":"traceutil/trace.go:171","msg":"trace[1860291860] linearizableReadLoop","detail":"{readStateIndex:8133; appliedIndex:8132; }","duration":"104.693216ms","start":"2026-03-18T01:02:02.300315Z","end":"2026-03-18T01:02:02.405008Z","steps":["trace[1860291860] 'read index received'  (duration: 44.336976ms)","trace[1860291860] 'applied index is now lower than readState.Index'  (duration: 60.35528ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T01:02:02.405148Z","caller":"traceutil/trace.go:171","msg":"trace[627178622] transaction","detail":"{read_only:false; response_revision:7844; number_of_response:1; }","duration":"183.96693ms","start":"2026-03-18T01:02:02.221165Z","end":"2026-03-18T01:02:02.405132Z","steps":["trace[627178622] 'process raft request'  (duration: 123.54983ms)","trace[627178622] 'compare'  (duration: 60.170455ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T01:02:02.405381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.053455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5146"}
{"level":"info","ts":"2026-03-18T01:02:02.405422Z","caller":"traceutil/trace.go:171","msg":"trace[415572580] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:7844; }","duration":"105.154689ms","start":"2026-03-18T01:02:02.300256Z","end":"2026-03-18T01:02:02.40541Z","steps":["trace[415572580] 'agreement among raft nodes before linearized reading'  (duration: 104.999254ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:02:02.628342Z","caller":"traceutil/trace.go:171","msg":"trace[310166379] linearizableReadLoop","detail":"{readStateIndex:8134; appliedIndex:8133; }","duration":"188.352188ms","start":"2026-03-18T01:02:02.439954Z","end":"2026-03-18T01:02:02.628306Z","steps":["trace[310166379] 'read index received'  (duration: 183.058497ms)","trace[310166379] 'applied index is now lower than readState.Index'  (duration: 5.292381ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T01:02:02.628371Z","caller":"traceutil/trace.go:171","msg":"trace[103570806] transaction","detail":"{read_only:false; response_revision:7845; number_of_response:1; }","duration":"206.42055ms","start":"2026-03-18T01:02:02.421921Z","end":"2026-03-18T01:02:02.628342Z","steps":["trace[103570806] 'process raft request'  (duration: 201.10325ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:02:02.628447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.48405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T01:02:02.628469Z","caller":"traceutil/trace.go:171","msg":"trace[541233083] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7845; }","duration":"188.573592ms","start":"2026-03-18T01:02:02.439889Z","end":"2026-03-18T01:02:02.628462Z","steps":["trace[541233083] 'agreement among raft nodes before linearized reading'  (duration: 188.510991ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:02:02.638726Z","caller":"traceutil/trace.go:171","msg":"trace[1547804838] transaction","detail":"{read_only:false; response_revision:7846; number_of_response:1; }","duration":"168.113141ms","start":"2026-03-18T01:02:02.470578Z","end":"2026-03-18T01:02:02.638691Z","steps":["trace[1547804838] 'process raft request'  (duration: 167.952708ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:02:08.58433Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5804}
{"level":"info","ts":"2026-03-18T01:02:08.677174Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5804,"took":"90.707593ms","hash":1467311457,"current-db-size-bytes":44081152,"current-db-size":"44 MB","current-db-size-in-use-bytes":23633920,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-03-18T01:02:08.677261Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1467311457,"revision":5804,"compact-revision":2789}
{"level":"warn","ts":"2026-03-18T01:02:56.392708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.340984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-18T01:02:56.392881Z","caller":"traceutil/trace.go:171","msg":"trace[147590093] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8357; }","duration":"307.551549ms","start":"2026-03-18T01:02:56.085304Z","end":"2026-03-18T01:02:56.392856Z","steps":["trace[147590093] 'range keys from in-memory index tree'  (duration: 307.13863ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:02:56.392946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T01:02:56.085293Z","time spent":"307.635971ms","remote":"127.0.0.1:46382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-18T01:02:56.392975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.352722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"}
{"level":"info","ts":"2026-03-18T01:02:56.393093Z","caller":"traceutil/trace.go:171","msg":"trace[1347160350] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8357; }","duration":"497.510636ms","start":"2026-03-18T01:02:55.895556Z","end":"2026-03-18T01:02:56.393067Z","steps":["trace[1347160350] 'range keys from in-memory index tree'  (duration: 497.093946ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:02:56.393157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T01:02:55.895538Z","time spent":"497.605099ms","remote":"127.0.0.1:46292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12234,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-03-18T01:02:56.393144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.028565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-18T01:02:56.393239Z","caller":"traceutil/trace.go:171","msg":"trace[1898720465] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8357; }","duration":"362.328913ms","start":"2026-03-18T01:02:56.030885Z","end":"2026-03-18T01:02:56.393214Z","steps":["trace[1898720465] 'range keys from in-memory index tree'  (duration: 361.84324ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:02:56.393288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T01:02:56.030864Z","time spent":"362.410174ms","remote":"127.0.0.1:46382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-18T01:02:56.392867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.268108ms","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-18T01:02:56.394069Z","caller":"traceutil/trace.go:171","msg":"trace[851457312] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8357; }","duration":"305.501049ms","start":"2026-03-18T01:02:56.088543Z","end":"2026-03-18T01:02:56.394044Z","steps":["trace[851457312] 'range keys from in-memory index tree'  (duration: 304.136125ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:02:56.394168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T01:02:56.088523Z","time spent":"305.59073ms","remote":"127.0.0.1:46382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-18T01:03:14.098227Z","caller":"traceutil/trace.go:171","msg":"trace[1238314487] linearizableReadLoop","detail":"{readStateIndex:8842; appliedIndex:8841; }","duration":"322.455838ms","start":"2026-03-18T01:03:13.77574Z","end":"2026-03-18T01:03:14.098196Z","steps":["trace[1238314487] 'read index received'  (duration: 322.221192ms)","trace[1238314487] 'applied index is now lower than readState.Index'  (duration: 233.266µs)"],"step_count":2}
{"level":"info","ts":"2026-03-18T01:03:14.098268Z","caller":"traceutil/trace.go:171","msg":"trace[2090755772] transaction","detail":"{read_only:false; response_revision:8533; number_of_response:1; }","duration":"398.749947ms","start":"2026-03-18T01:03:13.69949Z","end":"2026-03-18T01:03:14.09824Z","steps":["trace[2090755772] 'process raft request'  (duration: 398.508991ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:03:14.098375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.621072ms","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-03-18T01:03:14.098415Z","caller":"traceutil/trace.go:171","msg":"trace[1382528903] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:8533; }","duration":"322.681255ms","start":"2026-03-18T01:03:13.775723Z","end":"2026-03-18T01:03:14.098404Z","steps":["trace[1382528903] 'agreement among raft nodes before linearized reading'  (duration: 322.594092ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:03:14.098411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T01:03:13.699453Z","time spent":"398.87986ms","remote":"127.0.0.1:46382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:8478 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-03-18T01:03:14.09845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T01:03:13.775658Z","time spent":"322.782597ms","remote":"127.0.0.1:49890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true "}
{"level":"info","ts":"2026-03-18T01:04:08.411632Z","caller":"traceutil/trace.go:171","msg":"trace[1578527867] transaction","detail":"{read_only:false; response_revision:8907; number_of_response:1; }","duration":"212.504419ms","start":"2026-03-18T01:04:08.199102Z","end":"2026-03-18T01:04:08.411607Z","steps":["trace[1578527867] 'process raft request'  (duration: 212.248722ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:05:03.875164Z","caller":"traceutil/trace.go:171","msg":"trace[225879995] transaction","detail":"{read_only:false; response_revision:9265; number_of_response:1; }","duration":"101.566082ms","start":"2026-03-18T01:05:03.773571Z","end":"2026-03-18T01:05:03.875137Z","steps":["trace[225879995] 'process raft request'  (duration: 59.004089ms)","trace[225879995] 'compare'  (duration: 42.108242ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T01:05:04.132934Z","caller":"traceutil/trace.go:171","msg":"trace[1777679718] transaction","detail":"{read_only:false; response_revision:9267; number_of_response:1; }","duration":"108.056065ms","start":"2026-03-18T01:05:04.024849Z","end":"2026-03-18T01:05:04.132905Z","steps":["trace[1777679718] 'process raft request'  (duration: 107.811898ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:05:04.772051Z","caller":"traceutil/trace.go:171","msg":"trace[942513093] transaction","detail":"{read_only:false; response_revision:9268; number_of_response:1; }","duration":"217.464744ms","start":"2026-03-18T01:05:04.554546Z","end":"2026-03-18T01:05:04.772011Z","steps":["trace[942513093] 'process raft request'  (duration: 217.30688ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:05:05.092691Z","caller":"traceutil/trace.go:171","msg":"trace[1930049613] transaction","detail":"{read_only:false; response_revision:9270; number_of_response:1; }","duration":"272.136863ms","start":"2026-03-18T01:05:04.820532Z","end":"2026-03-18T01:05:05.092669Z","steps":["trace[1930049613] 'process raft request'  (duration: 236.188346ms)","trace[1930049613] 'compare'  (duration: 35.703881ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T01:05:05.297898Z","caller":"traceutil/trace.go:171","msg":"trace[287914466] linearizableReadLoop","detail":"{readStateIndex:9607; appliedIndex:9606; }","duration":"142.227088ms","start":"2026-03-18T01:05:05.155637Z","end":"2026-03-18T01:05:05.297864Z","steps":["trace[287914466] 'read index received'  (duration: 63.901202ms)","trace[287914466] 'applied index is now lower than readState.Index'  (duration: 78.324616ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T01:05:05.29795Z","caller":"traceutil/trace.go:171","msg":"trace[2015666005] transaction","detail":"{read_only:false; response_revision:9271; number_of_response:1; }","duration":"166.08189ms","start":"2026-03-18T01:05:05.131833Z","end":"2026-03-18T01:05:05.297915Z","steps":["trace[2015666005] 'process raft request'  (duration: 87.774005ms)","trace[2015666005] 'compare'  (duration: 78.074848ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T01:05:05.298398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.355406ms","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-18T01:05:05.29826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.599206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-18T01:05:05.298545Z","caller":"traceutil/trace.go:171","msg":"trace[1929872931] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9271; }","duration":"141.499869ms","start":"2026-03-18T01:05:05.157Z","end":"2026-03-18T01:05:05.298499Z","steps":["trace[1929872931] 'agreement among raft nodes before linearized reading'  (duration: 141.075099ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:05:05.298589Z","caller":"traceutil/trace.go:171","msg":"trace[845647289] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9271; }","duration":"142.965096ms","start":"2026-03-18T01:05:05.155602Z","end":"2026-03-18T01:05:05.298567Z","steps":["trace[845647289] 'agreement among raft nodes before linearized reading'  (duration: 142.439203ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:05:05.753451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.805777ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3939133440588234412 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:9259 > 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-18T01:05:05.753663Z","caller":"traceutil/trace.go:171","msg":"trace[98770722] transaction","detail":"{read_only:false; response_revision:9274; number_of_response:1; }","duration":"418.711679ms","start":"2026-03-18T01:05:05.334938Z","end":"2026-03-18T01:05:05.75365Z","steps":["trace[98770722] 'process raft request'  (duration: 418.673158ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:05:05.753714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T01:05:05.334914Z","time spent":"418.778681ms","remote":"127.0.0.1:46382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:9261 > 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-03-18T01:05:05.753833Z","caller":"traceutil/trace.go:171","msg":"trace[141749027] transaction","detail":"{read_only:false; response_revision:9273; number_of_response:1; }","duration":"448.315977ms","start":"2026-03-18T01:05:05.305458Z","end":"2026-03-18T01:05:05.753774Z","steps":["trace[141749027] 'process raft request'  (duration: 448.080761ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:05:05.753902Z","caller":"traceutil/trace.go:171","msg":"trace[1142003978] transaction","detail":"{read_only:false; response_revision:9272; number_of_response:1; }","duration":"449.573828ms","start":"2026-03-18T01:05:05.304306Z","end":"2026-03-18T01:05:05.75388Z","steps":["trace[1142003978] 'process raft request'  (duration: 119.265387ms)","trace[1142003978] 'compare'  (duration: 329.623873ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T01:05:05.75401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T01:05:05.304283Z","time spent":"449.66609ms","remote":"127.0.0.1:46382","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:9259 > 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-18T01:05:05.754081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T01:05:05.305432Z","time spent":"448.47552ms","remote":"127.0.0.1:46382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:9258 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-18T01:05:05.758441Z","caller":"traceutil/trace.go:171","msg":"trace[2125529070] linearizableReadLoop","detail":"{readStateIndex:9611; appliedIndex:9607; }","duration":"237.290835ms","start":"2026-03-18T01:05:05.521123Z","end":"2026-03-18T01:05:05.758414Z","steps":["trace[2125529070] 'read index received'  (duration: 226.535194ms)","trace[2125529070] 'applied index is now lower than readState.Index'  (duration: 10.754491ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T01:05:05.758552Z","caller":"traceutil/trace.go:171","msg":"trace[1791157896] transaction","detail":"{read_only:false; response_revision:9275; number_of_response:1; }","duration":"329.135462ms","start":"2026-03-18T01:05:05.429406Z","end":"2026-03-18T01:05:05.758541Z","steps":["trace[1791157896] 'process raft request'  (duration: 328.847924ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:05:05.758662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T01:05:05.429374Z","time spent":"329.211314ms","remote":"127.0.0.1:46382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:9262 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-03-18T01:05:05.758979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.696545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-18T01:05:05.759096Z","caller":"traceutil/trace.go:171","msg":"trace[42553438] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:9275; }","duration":"238.026853ms","start":"2026-03-18T01:05:05.521051Z","end":"2026-03-18T01:05:05.759078Z","steps":["trace[42553438] 'agreement among raft nodes before linearized reading'  (duration: 237.712046ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:05:05.759407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.401139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19314"}
{"level":"info","ts":"2026-03-18T01:05:05.759451Z","caller":"traceutil/trace.go:171","msg":"trace[159921376] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:9275; }","duration":"222.486701ms","start":"2026-03-18T01:05:05.536954Z","end":"2026-03-18T01:05:05.75944Z","steps":["trace[159921376] 'agreement among raft nodes before linearized reading'  (duration: 222.372338ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:05:07.304359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.822979ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3939133440588234447 > lease_revoke:<id:36aa9cfe691fbde4>","response":"size:27"}
{"level":"info","ts":"2026-03-18T01:05:07.304485Z","caller":"traceutil/trace.go:171","msg":"trace[1770879833] linearizableReadLoop","detail":"{readStateIndex:9622; appliedIndex:9621; }","duration":"250.17965ms","start":"2026-03-18T01:05:07.054282Z","end":"2026-03-18T01:05:07.304462Z","steps":["trace[1770879833] 'read index received'  (duration: 72.312µs)","trace[1770879833] 'applied index is now lower than readState.Index'  (duration: 250.105247ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T01:05:07.30464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.338904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T01:05:07.304702Z","caller":"traceutil/trace.go:171","msg":"trace[1533327790] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:9285; }","duration":"250.447066ms","start":"2026-03-18T01:05:07.054239Z","end":"2026-03-18T01:05:07.304686Z","steps":["trace[1533327790] 'agreement among raft nodes before linearized reading'  (duration: 250.334343ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:05:07.40952Z","caller":"traceutil/trace.go:171","msg":"trace[1951414566] transaction","detail":"{read_only:false; response_revision:9286; number_of_response:1; }","duration":"101.824938ms","start":"2026-03-18T01:05:07.307664Z","end":"2026-03-18T01:05:07.409489Z","steps":["trace[1951414566] 'process raft request'  (duration: 101.641304ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:05:07.938378Z","caller":"traceutil/trace.go:171","msg":"trace[1409152225] transaction","detail":"{read_only:false; response_revision:9291; number_of_response:1; }","duration":"103.682335ms","start":"2026-03-18T01:05:07.834671Z","end":"2026-03-18T01:05:07.938353Z","steps":["trace[1409152225] 'process raft request'  (duration: 59.000368ms)","trace[1409152225] 'compare'  (duration: 44.454561ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T01:05:09.889084Z","caller":"traceutil/trace.go:171","msg":"trace[534831247] transaction","detail":"{read_only:false; response_revision:9296; number_of_response:1; }","duration":"104.986028ms","start":"2026-03-18T01:05:09.784071Z","end":"2026-03-18T01:05:09.889057Z","steps":["trace[534831247] 'process raft request'  (duration: 104.407223ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:05:09.889243Z","caller":"traceutil/trace.go:171","msg":"trace[1096319678] transaction","detail":"{read_only:false; response_revision:9297; number_of_response:1; }","duration":"103.449109ms","start":"2026-03-18T01:05:09.785761Z","end":"2026-03-18T01:05:09.889211Z","steps":["trace[1096319678] 'process raft request'  (duration: 103.161821ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:05:09.889658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.178217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:130177"}
{"level":"info","ts":"2026-03-18T01:05:09.889722Z","caller":"traceutil/trace.go:171","msg":"trace[1235848221] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:9298; }","duration":"106.248919ms","start":"2026-03-18T01:05:09.783459Z","end":"2026-03-18T01:05:09.889708Z","steps":["trace[1235848221] 'agreement among raft nodes before linearized reading'  (duration: 106.117655ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:05:10.9215Z","caller":"traceutil/trace.go:171","msg":"trace[491830208] linearizableReadLoop","detail":"{readStateIndex:9643; appliedIndex:9642; }","duration":"132.208944ms","start":"2026-03-18T01:05:10.789274Z","end":"2026-03-18T01:05:10.921483Z","steps":["trace[491830208] 'read index received'  (duration: 132.03927ms)","trace[491830208] 'applied index is now lower than readState.Index'  (duration: 168.964µs)"],"step_count":2}
{"level":"info","ts":"2026-03-18T01:05:10.921582Z","caller":"traceutil/trace.go:171","msg":"trace[1192704909] transaction","detail":"{read_only:false; response_revision:9306; number_of_response:1; }","duration":"132.327837ms","start":"2026-03-18T01:05:10.78921Z","end":"2026-03-18T01:05:10.921538Z","steps":["trace[1192704909] 'process raft request'  (duration: 132.161263ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T01:05:10.921654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.365168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/glance-api-65555dc78-7ws8k\" ","response":"range_response_count:1 size:13132"}
{"level":"info","ts":"2026-03-18T01:05:10.921681Z","caller":"traceutil/trace.go:171","msg":"trace[252945222] range","detail":"{range_begin:/registry/pods/openstack/glance-api-65555dc78-7ws8k; range_end:; response_count:1; response_revision:9306; }","duration":"132.43495ms","start":"2026-03-18T01:05:10.789238Z","end":"2026-03-18T01:05:10.921673Z","steps":["trace[252945222] 'agreement among raft nodes before linearized reading'  (duration: 132.311046ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:05:11.064581Z","caller":"traceutil/trace.go:171","msg":"trace[1558566363] transaction","detail":"{read_only:false; response_revision:9307; number_of_response:1; }","duration":"125.464565ms","start":"2026-03-18T01:05:10.939097Z","end":"2026-03-18T01:05:11.064562Z","steps":["trace[1558566363] 'process raft request'  (duration: 125.348121ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T01:05:52.226339Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"23887246632736aa","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-03-18T01:05:52.231138Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-03-18T01:05:52.231255Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-03-18T01:07:08.590315Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7894}
{"level":"info","ts":"2026-03-18T01:07:08.650298Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7894,"took":"57.713205ms","hash":3710009775,"current-db-size-bytes":44081152,"current-db-size":"44 MB","current-db-size-in-use-bytes":25767936,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-03-18T01:07:08.650365Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3710009775,"revision":7894,"compact-revision":5804}
{"level":"info","ts":"2026-03-18T01:12:08.59862Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10023}
{"level":"info","ts":"2026-03-18T01:12:08.672988Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10023,"took":"72.01913ms","hash":3603235043,"current-db-size-bytes":44081152,"current-db-size":"44 MB","current-db-size-in-use-bytes":16637952,"current-db-size-in-use":"17 MB"}
{"level":"info","ts":"2026-03-18T01:12:08.673049Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3603235043,"revision":10023,"compact-revision":7894}