{"level":"warn","ts":"2026-03-05T06:39:04.5917Z","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-05T06:39:04.591793Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.195: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.195:2380","--initial-cluster=instance=https://162.253.55.195:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.195:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.195: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-05T06:39:04.591876Z","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-05T06:39:04.591888Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.195:2380"]}
{"level":"info","ts":"2026-03-05T06:39:04.591906Z","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-05T06:39:04.592492Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"]}
{"level":"info","ts":"2026-03-05T06:39:04.59262Z","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.195:2380"],"listen-peer-urls":["https://162.253.55.195:2380"],"advertise-client-urls":["https://162.253.55.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.195: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-05T06:39:04.597039Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.145127ms"}
{"level":"info","ts":"2026-03-05T06:39:04.606476Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b66d12fd59101739","cluster-id":"a64a525934ce8379"}
{"level":"info","ts":"2026-03-05T06:39:04.606599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-05T06:39:04.606676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became follower at term 0"}
{"level":"info","ts":"2026-03-05T06:39:04.606705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b66d12fd59101739 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-05T06:39:04.60673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became follower at term 1"}
{"level":"info","ts":"2026-03-05T06:39:04.606796Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=(13145183766694598457)"}
{"level":"warn","ts":"2026-03-05T06:39:04.615258Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-05T06:39:04.618939Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-05T06:39:04.620228Z","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-05T06:39:04.623154Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b66d12fd59101739","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-05T06:39:04.623358Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b66d12fd59101739","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-05T06:39:04.623592Z","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-05T06:39:04.623792Z","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-05T06:39:04.623818Z","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-05T06:39:04.624425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=(13145183766694598457)"}
{"level":"info","ts":"2026-03-05T06:39:04.624561Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a64a525934ce8379","local-member-id":"b66d12fd59101739","added-peer-id":"b66d12fd59101739","added-peer-peer-urls":["https://162.253.55.195:2380"]}
{"level":"info","ts":"2026-03-05T06:39:04.626451Z","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-05T06:39:04.626767Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b66d12fd59101739","initial-advertise-peer-urls":["https://162.253.55.195:2380"],"listen-peer-urls":["https://162.253.55.195:2380"],"advertise-client-urls":["https://162.253.55.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-05T06:39:04.626836Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-05T06:39:04.626998Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.195:2380"}
{"level":"info","ts":"2026-03-05T06:39:04.627085Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.195:2380"}
{"level":"info","ts":"2026-03-05T06:39:05.117394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-05T06:39:05.117471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-05T06:39:05.117501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 received MsgPreVoteResp from b66d12fd59101739 at term 1"}
{"level":"info","ts":"2026-03-05T06:39:05.117518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became candidate at term 2"}
{"level":"info","ts":"2026-03-05T06:39:05.117523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 received MsgVoteResp from b66d12fd59101739 at term 2"}
{"level":"info","ts":"2026-03-05T06:39:05.117533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became leader at term 2"}
{"level":"info","ts":"2026-03-05T06:39:05.117541Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b66d12fd59101739 elected leader b66d12fd59101739 at term 2"}
{"level":"info","ts":"2026-03-05T06:39:05.118372Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b66d12fd59101739","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.195:2379]}","request-path":"/0/members/b66d12fd59101739/attributes","cluster-id":"a64a525934ce8379","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-05T06:39:05.118409Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-05T06:39:05.118465Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-05T06:39:05.118472Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-05T06:39:05.119575Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a64a525934ce8379","local-member-id":"b66d12fd59101739","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-05T06:39:05.119881Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-05T06:39:05.119986Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-05T06:39:05.121482Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.195:2379"}
{"level":"info","ts":"2026-03-05T06:39:05.123416Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-05T06:39:05.12988Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-05T06:39:05.129928Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"warn","ts":"2026-03-05T06:39:22.894967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.249634ms","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-05T06:39:22.895044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.223655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-05T06:39:22.895102Z","caller":"traceutil/trace.go:171","msg":"trace[188586083] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:447; }","duration":"264.301646ms","start":"2026-03-05T06:39:22.630782Z","end":"2026-03-05T06:39:22.895083Z","steps":["trace[188586083] 'range keys from in-memory index tree'  (duration: 264.138322ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:39:22.894949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.712691ms","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-05T06:39:22.895138Z","caller":"traceutil/trace.go:171","msg":"trace[910820535] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:447; }","duration":"132.991368ms","start":"2026-03-05T06:39:22.762138Z","end":"2026-03-05T06:39:22.895129Z","steps":["trace[910820535] 'range keys from in-memory index tree'  (duration: 132.592658ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:39:22.895089Z","caller":"traceutil/trace.go:171","msg":"trace[80939188] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:447; }","duration":"264.422628ms","start":"2026-03-05T06:39:22.630645Z","end":"2026-03-05T06:39:22.895067Z","steps":["trace[80939188] 'range keys from in-memory index tree'  (duration: 264.150953ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:39:23.096823Z","caller":"traceutil/trace.go:171","msg":"trace[2059246546] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"196.773778ms","start":"2026-03-05T06:39:22.900025Z","end":"2026-03-05T06:39:23.096799Z","steps":["trace[2059246546] 'process raft request'  (duration: 196.605614ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:39:23.543402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.311424ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1673541070910759642 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:415 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-05T06:39:23.543587Z","caller":"traceutil/trace.go:171","msg":"trace[1049912461] linearizableReadLoop","detail":"{readStateIndex:464; appliedIndex:462; }","duration":"426.715542ms","start":"2026-03-05T06:39:23.116853Z","end":"2026-03-05T06:39:23.543569Z","steps":["trace[1049912461] 'read index received'  (duration: 216.64963ms)","trace[1049912461] 'applied index is now lower than readState.Index'  (duration: 210.064952ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T06:39:23.543649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.803964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T06:39:23.543673Z","caller":"traceutil/trace.go:171","msg":"trace[172651149] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:450; }","duration":"426.828355ms","start":"2026-03-05T06:39:23.116836Z","end":"2026-03-05T06:39:23.543664Z","steps":["trace[172651149] 'agreement among raft nodes before linearized reading'  (duration: 426.786894ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:39:23.543709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:39:23.116776Z","time spent":"426.926026ms","remote":"127.0.0.1:38190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-05T06:39:23.543716Z","caller":"traceutil/trace.go:171","msg":"trace[511949748] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"643.517223ms","start":"2026-03-05T06:39:22.90013Z","end":"2026-03-05T06:39:23.543647Z","steps":["trace[511949748] 'process raft request'  (duration: 433.400399ms)","trace[511949748] 'compare'  (duration: 209.169271ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:39:23.543759Z","caller":"traceutil/trace.go:171","msg":"trace[1059798419] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"643.594265ms","start":"2026-03-05T06:39:22.900142Z","end":"2026-03-05T06:39:23.543737Z","steps":["trace[1059798419] 'process raft request'  (duration: 643.36554ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:39:23.543871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:39:22.900113Z","time spent":"643.688748ms","remote":"127.0.0.1:38472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:414 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-05T06:39:23.543879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:39:22.900101Z","time spent":"643.695238ms","remote":"127.0.0.1:38472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:415 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-05T06:39:34.777902Z","caller":"traceutil/trace.go:171","msg":"trace[586032732] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"147.818034ms","start":"2026-03-05T06:39:34.630052Z","end":"2026-03-05T06:39:34.77787Z","steps":["trace[586032732] 'process raft request'  (duration: 147.659201ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:39:41.863098Z","caller":"traceutil/trace.go:171","msg":"trace[2088534112] linearizableReadLoop","detail":"{readStateIndex:570; appliedIndex:569; }","duration":"153.198185ms","start":"2026-03-05T06:39:41.70987Z","end":"2026-03-05T06:39:41.863069Z","steps":["trace[2088534112] 'read index received'  (duration: 153.064452ms)","trace[2088534112] 'applied index is now lower than readState.Index'  (duration: 132.943µs)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:39:41.863182Z","caller":"traceutil/trace.go:171","msg":"trace[769251188] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"183.373627ms","start":"2026-03-05T06:39:41.67975Z","end":"2026-03-05T06:39:41.863124Z","steps":["trace[769251188] 'process raft request'  (duration: 183.191422ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:39:41.863308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.41467ms","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-05T06:39:41.863352Z","caller":"traceutil/trace.go:171","msg":"trace[1120493713] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:552; }","duration":"153.490922ms","start":"2026-03-05T06:39:41.709842Z","end":"2026-03-05T06:39:41.863333Z","steps":["trace[1120493713] 'agreement among raft nodes before linearized reading'  (duration: 153.329388ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:40:02.482619Z","caller":"traceutil/trace.go:171","msg":"trace[1155222944] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"127.241246ms","start":"2026-03-05T06:40:02.355353Z","end":"2026-03-05T06:40:02.482594Z","steps":["trace[1155222944] 'process raft request'  (duration: 127.046712ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:40:02.482606Z","caller":"traceutil/trace.go:171","msg":"trace[670193983] linearizableReadLoop","detail":"{readStateIndex:956; appliedIndex:955; }","duration":"118.521915ms","start":"2026-03-05T06:40:02.364059Z","end":"2026-03-05T06:40:02.48258Z","steps":["trace[670193983] 'read index received'  (duration: 118.379352ms)","trace[670193983] 'applied index is now lower than readState.Index'  (duration: 141.473µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T06:40:02.48284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.75973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/cert-manager/cert-manager-webhook-548949fc64-x6vjz\" ","response":"range_response_count:1 size:5353"}
{"level":"info","ts":"2026-03-05T06:40:02.482908Z","caller":"traceutil/trace.go:171","msg":"trace[199284362] range","detail":"{range_begin:/registry/pods/cert-manager/cert-manager-webhook-548949fc64-x6vjz; range_end:; response_count:1; response_revision:931; }","duration":"118.882053ms","start":"2026-03-05T06:40:02.364009Z","end":"2026-03-05T06:40:02.482891Z","steps":["trace[199284362] 'agreement among raft nodes before linearized reading'  (duration: 118.661228ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:40:48.588789Z","caller":"traceutil/trace.go:171","msg":"trace[1161518225] linearizableReadLoop","detail":"{readStateIndex:1643; appliedIndex:1642; }","duration":"174.430432ms","start":"2026-03-05T06:40:48.414329Z","end":"2026-03-05T06:40:48.588759Z","steps":["trace[1161518225] 'read index received'  (duration: 130.225874ms)","trace[1161518225] 'applied index is now lower than readState.Index'  (duration: 44.203518ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:40:48.588824Z","caller":"traceutil/trace.go:171","msg":"trace[1590748511] transaction","detail":"{read_only:false; response_revision:1580; number_of_response:1; }","duration":"339.058359ms","start":"2026-03-05T06:40:48.249727Z","end":"2026-03-05T06:40:48.588785Z","steps":["trace[1590748511] 'process raft request'  (duration: 294.879072ms)","trace[1590748511] 'compare'  (duration: 44.041674ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T06:40:48.589008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:40:48.249703Z","time spent":"339.209552ms","remote":"127.0.0.1:38472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1510 > 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-05T06:40:48.589088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.72827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c30e52ba-cf87-4f9c-8ec2-5817f8c37269\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-03-05T06:40:48.589189Z","caller":"traceutil/trace.go:171","msg":"trace[1350084196] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c30e52ba-cf87-4f9c-8ec2-5817f8c37269; range_end:; response_count:1; response_revision:1580; }","duration":"174.894614ms","start":"2026-03-05T06:40:48.414269Z","end":"2026-03-05T06:40:48.589163Z","steps":["trace[1350084196] 'agreement among raft nodes before linearized reading'  (duration: 174.603567ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:40:48.840122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.114165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c30e52ba-cf87-4f9c-8ec2-5817f8c37269\" ","response":"range_response_count:1 size:3747"}
{"level":"info","ts":"2026-03-05T06:40:48.840226Z","caller":"traceutil/trace.go:171","msg":"trace[894154367] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c30e52ba-cf87-4f9c-8ec2-5817f8c37269; range_end:; response_count:1; response_revision:1581; }","duration":"121.294229ms","start":"2026-03-05T06:40:48.718907Z","end":"2026-03-05T06:40:48.840201Z","steps":["trace[894154367] 'range keys from in-memory index tree'  (duration: 121.015343ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:43:04.342233Z","caller":"traceutil/trace.go:171","msg":"trace[1246395787] transaction","detail":"{read_only:false; response_revision:2496; number_of_response:1; }","duration":"160.822999ms","start":"2026-03-05T06:43:04.181384Z","end":"2026-03-05T06:43:04.342207Z","steps":["trace[1246395787] 'process raft request'  (duration: 160.685426ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:43:04.346722Z","caller":"traceutil/trace.go:171","msg":"trace[288789316] transaction","detail":"{read_only:false; response_revision:2497; number_of_response:1; }","duration":"111.636204ms","start":"2026-03-05T06:43:04.235059Z","end":"2026-03-05T06:43:04.346695Z","steps":["trace[288789316] 'process raft request'  (duration: 111.501711ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:43:04.481278Z","caller":"traceutil/trace.go:171","msg":"trace[1084179879] transaction","detail":"{read_only:false; response_revision:2498; number_of_response:1; }","duration":"117.352711ms","start":"2026-03-05T06:43:04.363902Z","end":"2026-03-05T06:43:04.481254Z","steps":["trace[1084179879] 'process raft request'  (duration: 109.370531ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:43:04.794647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.746939ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1673541070910763995 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2490 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-05T06:43:04.794897Z","caller":"traceutil/trace.go:171","msg":"trace[116924445] transaction","detail":"{read_only:false; response_revision:2499; number_of_response:1; }","duration":"257.121121ms","start":"2026-03-05T06:43:04.537753Z","end":"2026-03-05T06:43:04.794874Z","steps":["trace[116924445] 'process raft request'  (duration: 74.032704ms)","trace[116924445] 'compare'  (duration: 182.493583ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:43:04.795104Z","caller":"traceutil/trace.go:171","msg":"trace[1985556367] linearizableReadLoop","detail":"{readStateIndex:2599; appliedIndex:2597; }","duration":"103.05268ms","start":"2026-03-05T06:43:04.692018Z","end":"2026-03-05T06:43:04.79507Z","steps":["trace[1985556367] 'read index received'  (duration: 96.466995ms)","trace[1985556367] 'applied index is now lower than readState.Index'  (duration: 6.584355ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:43:04.795129Z","caller":"traceutil/trace.go:171","msg":"trace[2016552734] transaction","detail":"{read_only:false; response_revision:2500; number_of_response:1; }","duration":"153.974168ms","start":"2026-03-05T06:43:04.641111Z","end":"2026-03-05T06:43:04.795086Z","steps":["trace[2016552734] 'process raft request'  (duration: 153.65868ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:43:04.795254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.224204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T06:43:04.795289Z","caller":"traceutil/trace.go:171","msg":"trace[1175687314] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:2500; }","duration":"103.332487ms","start":"2026-03-05T06:43:04.691948Z","end":"2026-03-05T06:43:04.79528Z","steps":["trace[1175687314] 'agreement among raft nodes before linearized reading'  (duration: 103.237115ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:47:10.979084Z","caller":"traceutil/trace.go:171","msg":"trace[980960323] transaction","detail":"{read_only:false; response_revision:4600; number_of_response:1; }","duration":"281.525601ms","start":"2026-03-05T06:47:10.697512Z","end":"2026-03-05T06:47:10.979037Z","steps":["trace[980960323] 'process raft request'  (duration: 247.671896ms)","trace[980960323] 'compare'  (duration: 33.437626ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:47:11.023179Z","caller":"traceutil/trace.go:171","msg":"trace[1610718537] linearizableReadLoop","detail":"{readStateIndex:4786; appliedIndex:4783; }","duration":"311.484715ms","start":"2026-03-05T06:47:10.711641Z","end":"2026-03-05T06:47:11.023126Z","steps":["trace[1610718537] 'read index received'  (duration: 233.621619ms)","trace[1610718537] 'applied index is now lower than readState.Index'  (duration: 77.861986ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:47:11.023558Z","caller":"traceutil/trace.go:171","msg":"trace[1963402214] transaction","detail":"{read_only:false; response_revision:4601; number_of_response:1; }","duration":"325.681705ms","start":"2026-03-05T06:47:10.697864Z","end":"2026-03-05T06:47:11.023545Z","steps":["trace[1963402214] 'process raft request'  (duration: 324.470106ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:47:11.024853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:47:10.69782Z","time spent":"326.984305ms","remote":"127.0.0.1:38488","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1401,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/endpointslices/monitoring/vector-headless-kqv27\" mod_revision:0 > success:<request_put:<key:\"/registry/endpointslices/monitoring/vector-headless-kqv27\" value_size:1336 >> failure:<>"}
{"level":"info","ts":"2026-03-05T06:47:11.023655Z","caller":"traceutil/trace.go:171","msg":"trace[1892963428] transaction","detail":"{read_only:false; response_revision:4602; number_of_response:1; }","duration":"317.861344ms","start":"2026-03-05T06:47:10.705779Z","end":"2026-03-05T06:47:11.023641Z","steps":["trace[1892963428] 'process raft request'  (duration: 316.717617ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:47:11.025017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:47:10.705758Z","time spent":"319.241625ms","remote":"127.0.0.1:38670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4833,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/daemonsets/monitoring/vector\" mod_revision:0 > success:<request_put:<key:\"/registry/daemonsets/monitoring/vector\" value_size:4787 >> failure:<>"}
{"level":"warn","ts":"2026-03-05T06:47:11.024282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.718108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4b29b50b-dfc6-467c-ba69-24754eb887c1\" ","response":"range_response_count:1 size:3601"}
{"level":"info","ts":"2026-03-05T06:47:11.025182Z","caller":"traceutil/trace.go:171","msg":"trace[1921403555] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4b29b50b-dfc6-467c-ba69-24754eb887c1; range_end:; response_count:1; response_revision:4603; }","duration":"186.843104ms","start":"2026-03-05T06:47:10.838327Z","end":"2026-03-05T06:47:11.025171Z","steps":["trace[1921403555] 'agreement among raft nodes before linearized reading'  (duration: 185.563005ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:47:11.024387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.746114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-05T06:47:11.025421Z","caller":"traceutil/trace.go:171","msg":"trace[1919652618] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4603; }","duration":"313.835781ms","start":"2026-03-05T06:47:10.711577Z","end":"2026-03-05T06:47:11.025413Z","steps":["trace[1919652618] 'agreement among raft nodes before linearized reading'  (duration: 312.723555ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:47:11.025463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T06:47:10.711565Z","time spent":"313.890782ms","remote":"127.0.0.1:38472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-05T06:47:11.285564Z","caller":"traceutil/trace.go:171","msg":"trace[691626165] transaction","detail":"{read_only:false; response_revision:4609; number_of_response:1; }","duration":"157.680218ms","start":"2026-03-05T06:47:11.127852Z","end":"2026-03-05T06:47:11.285532Z","steps":["trace[691626165] 'process raft request'  (duration: 114.779893ms)","trace[691626165] 'compare'  (duration: 42.645779ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:47:11.285609Z","caller":"traceutil/trace.go:171","msg":"trace[1727710081] linearizableReadLoop","detail":"{readStateIndex:4794; appliedIndex:4791; }","duration":"139.599737ms","start":"2026-03-05T06:47:11.14596Z","end":"2026-03-05T06:47:11.28556Z","steps":["trace[1727710081] 'read index received'  (duration: 12.360146ms)","trace[1727710081] 'applied index is now lower than readState.Index'  (duration: 127.238411ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:47:11.285761Z","caller":"traceutil/trace.go:171","msg":"trace[922174882] transaction","detail":"{read_only:false; response_revision:4610; number_of_response:1; }","duration":"157.067964ms","start":"2026-03-05T06:47:11.128647Z","end":"2026-03-05T06:47:11.285715Z","steps":["trace[922174882] 'process raft request'  (duration: 156.815468ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:47:11.285841Z","caller":"traceutil/trace.go:171","msg":"trace[1807575880] transaction","detail":"{read_only:false; response_revision:4611; number_of_response:1; }","duration":"123.161716ms","start":"2026-03-05T06:47:11.162627Z","end":"2026-03-05T06:47:11.285789Z","steps":["trace[1807575880] 'process raft request'  (duration: 122.909381ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:47:11.286283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.308455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:777485"}
{"level":"info","ts":"2026-03-05T06:47:11.286342Z","caller":"traceutil/trace.go:171","msg":"trace[796320068] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:4611; }","duration":"140.437468ms","start":"2026-03-05T06:47:11.145888Z","end":"2026-03-05T06:47:11.286326Z","steps":["trace[796320068] 'agreement among raft nodes before linearized reading'  (duration: 139.825563ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:47:11.304134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.633316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/vector-7g9ns\" ","response":"range_response_count:1 size:4949"}
{"level":"info","ts":"2026-03-05T06:47:11.304217Z","caller":"traceutil/trace.go:171","msg":"trace[2097481862] range","detail":"{range_begin:/registry/pods/monitoring/vector-7g9ns; range_end:; response_count:1; response_revision:4613; }","duration":"135.778559ms","start":"2026-03-05T06:47:11.168419Z","end":"2026-03-05T06:47:11.304198Z","steps":["trace[2097481862] 'agreement among raft nodes before linearized reading'  (duration: 135.437261ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:47:11.458883Z","caller":"traceutil/trace.go:171","msg":"trace[151316921] transaction","detail":"{read_only:false; response_revision:4614; number_of_response:1; }","duration":"147.335907ms","start":"2026-03-05T06:47:11.311502Z","end":"2026-03-05T06:47:11.458838Z","steps":["trace[151316921] 'process raft request'  (duration: 80.902106ms)","trace[151316921] 'compare'  (duration: 66.203006ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T06:47:30.860814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.940178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3dfe062a-3e8c-412d-9e1b-5a9429237c2b\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-03-05T06:47:30.860947Z","caller":"traceutil/trace.go:171","msg":"trace[308876222] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3dfe062a-3e8c-412d-9e1b-5a9429237c2b; range_end:; response_count:1; response_revision:4996; }","duration":"147.145023ms","start":"2026-03-05T06:47:30.713773Z","end":"2026-03-05T06:47:30.860918Z","steps":["trace[308876222] 'range keys from in-memory index tree'  (duration: 146.725813ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:47:31.286739Z","caller":"traceutil/trace.go:171","msg":"trace[1490537777] linearizableReadLoop","detail":"{readStateIndex:5190; appliedIndex:5189; }","duration":"135.254077ms","start":"2026-03-05T06:47:31.151443Z","end":"2026-03-05T06:47:31.286697Z","steps":["trace[1490537777] 'read index received'  (duration: 134.204054ms)","trace[1490537777] 'applied index is now lower than readState.Index'  (duration: 1.048723ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T06:47:31.287275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.80766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-05T06:47:31.287323Z","caller":"traceutil/trace.go:171","msg":"trace[140178528] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4998; }","duration":"135.931322ms","start":"2026-03-05T06:47:31.151377Z","end":"2026-03-05T06:47:31.287309Z","steps":["trace[140178528] 'agreement among raft nodes before linearized reading'  (duration: 135.669276ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:47:31.287678Z","caller":"traceutil/trace.go:171","msg":"trace[1864987433] transaction","detail":"{read_only:false; response_revision:4998; number_of_response:1; }","duration":"161.835273ms","start":"2026-03-05T06:47:31.125805Z","end":"2026-03-05T06:47:31.28764Z","steps":["trace[1864987433] 'process raft request'  (duration: 159.96924ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:47:32.972511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.045092ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1673541070910770043 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/openstack/memcached-memcached-6479589586-flwsk\" mod_revision:5031 > success:<request_put:<key:\"/registry/pods/openstack/memcached-memcached-6479589586-flwsk\" value_size:8346 >> failure:<request_range:<key:\"/registry/pods/openstack/memcached-memcached-6479589586-flwsk\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-05T06:47:32.972732Z","caller":"traceutil/trace.go:171","msg":"trace[1038210231] linearizableReadLoop","detail":"{readStateIndex:5226; appliedIndex:5225; }","duration":"188.556183ms","start":"2026-03-05T06:47:32.784154Z","end":"2026-03-05T06:47:32.97271Z","steps":["trace[1038210231] 'read index received'  (duration: 21.975799ms)","trace[1038210231] 'applied index is now lower than readState.Index'  (duration: 166.578984ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:47:32.972839Z","caller":"traceutil/trace.go:171","msg":"trace[1950554532] transaction","detail":"{read_only:false; response_revision:5033; number_of_response:1; }","duration":"193.004378ms","start":"2026-03-05T06:47:32.779813Z","end":"2026-03-05T06:47:32.972818Z","steps":["trace[1950554532] 'process raft request'  (duration: 26.537086ms)","trace[1950554532] 'compare'  (duration: 165.833097ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:47:32.973467Z","caller":"traceutil/trace.go:171","msg":"trace[1445225645] transaction","detail":"{read_only:false; response_revision:5034; number_of_response:1; }","duration":"183.084786ms","start":"2026-03-05T06:47:32.790369Z","end":"2026-03-05T06:47:32.973454Z","steps":["trace[1445225645] 'process raft request'  (duration: 182.279648ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:47:32.973631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.435044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"}
{"level":"info","ts":"2026-03-05T06:47:32.973725Z","caller":"traceutil/trace.go:171","msg":"trace[1269733388] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:5034; }","duration":"189.573527ms","start":"2026-03-05T06:47:32.784131Z","end":"2026-03-05T06:47:32.973704Z","steps":["trace[1269733388] 'agreement among raft nodes before linearized reading'  (duration: 188.692407ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:47:32.973788Z","caller":"traceutil/trace.go:171","msg":"trace[1997192655] transaction","detail":"{read_only:false; response_revision:5035; number_of_response:1; }","duration":"183.112598ms","start":"2026-03-05T06:47:32.790664Z","end":"2026-03-05T06:47:32.973777Z","steps":["trace[1997192655] 'process raft request'  (duration: 182.923813ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:47:32.974009Z","caller":"traceutil/trace.go:171","msg":"trace[1985580686] transaction","detail":"{read_only:false; response_revision:5038; number_of_response:1; }","duration":"183.033356ms","start":"2026-03-05T06:47:32.790966Z","end":"2026-03-05T06:47:32.973999Z","steps":["trace[1985580686] 'process raft request'  (duration: 182.78704ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:47:32.97408Z","caller":"traceutil/trace.go:171","msg":"trace[1203736296] transaction","detail":"{read_only:false; response_revision:5036; number_of_response:1; }","duration":"183.347132ms","start":"2026-03-05T06:47:32.790726Z","end":"2026-03-05T06:47:32.974073Z","steps":["trace[1203736296] 'process raft request'  (duration: 182.956234ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:47:32.974138Z","caller":"traceutil/trace.go:171","msg":"trace[540895443] transaction","detail":"{read_only:false; response_revision:5037; number_of_response:1; }","duration":"183.280882ms","start":"2026-03-05T06:47:32.79085Z","end":"2026-03-05T06:47:32.974131Z","steps":["trace[540895443] 'process raft request'  (duration: 182.858541ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:47:32.974164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.052628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3dfe062a-3e8c-412d-9e1b-5a9429237c2b\" ","response":"range_response_count:1 size:3952"}
{"level":"info","ts":"2026-03-05T06:47:32.974197Z","caller":"traceutil/trace.go:171","msg":"trace[790651827] transaction","detail":"{read_only:false; response_revision:5039; number_of_response:1; }","duration":"183.091508ms","start":"2026-03-05T06:47:32.791099Z","end":"2026-03-05T06:47:32.97419Z","steps":["trace[790651827] 'process raft request'  (duration: 182.677788ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:47:32.974221Z","caller":"traceutil/trace.go:171","msg":"trace[1993100793] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3dfe062a-3e8c-412d-9e1b-5a9429237c2b; range_end:; response_count:1; response_revision:5040; }","duration":"102.171651ms","start":"2026-03-05T06:47:32.87204Z","end":"2026-03-05T06:47:32.974212Z","steps":["trace[1993100793] 'agreement among raft nodes before linearized reading'  (duration: 101.946685ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:47:32.974303Z","caller":"traceutil/trace.go:171","msg":"trace[217461966] transaction","detail":"{read_only:false; response_revision:5040; number_of_response:1; }","duration":"175.671715ms","start":"2026-03-05T06:47:32.798617Z","end":"2026-03-05T06:47:32.974289Z","steps":["trace[217461966] 'process raft request'  (duration: 175.180653ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:49:05.155749Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2797}
{"level":"info","ts":"2026-03-05T06:49:05.21746Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2797,"took":"59.932125ms","hash":446762872,"current-db-size-bytes":41476096,"current-db-size":"42 MB","current-db-size-in-use-bytes":30851072,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-03-05T06:49:05.217647Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":446762872,"revision":2797,"compact-revision":-1}
{"level":"warn","ts":"2026-03-05T06:53:35.810492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.260592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T06:53:35.810611Z","caller":"traceutil/trace.go:171","msg":"trace[794499943] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:7640; }","duration":"198.464757ms","start":"2026-03-05T06:53:35.612122Z","end":"2026-03-05T06:53:35.810586Z","steps":["trace[794499943] 'range keys from in-memory index tree'  (duration: 198.18028ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:53:47.361005Z","caller":"traceutil/trace.go:171","msg":"trace[436274225] transaction","detail":"{read_only:false; response_revision:7694; number_of_response:1; }","duration":"125.939554ms","start":"2026-03-05T06:53:47.235014Z","end":"2026-03-05T06:53:47.360954Z","steps":["trace[436274225] 'process raft request'  (duration: 125.688968ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:53:47.634522Z","caller":"traceutil/trace.go:171","msg":"trace[965279429] transaction","detail":"{read_only:false; response_revision:7695; number_of_response:1; }","duration":"268.189367ms","start":"2026-03-05T06:53:47.366291Z","end":"2026-03-05T06:53:47.634481Z","steps":["trace[965279429] 'process raft request'  (duration: 233.132064ms)","trace[965279429] 'compare'  (duration: 34.845878ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T06:53:48.343626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.464997ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1673541070910777318 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:17399cbcb8a9e7e5>","response":"size:41"}
{"level":"info","ts":"2026-03-05T06:53:48.499851Z","caller":"traceutil/trace.go:171","msg":"trace[1791482712] linearizableReadLoop","detail":"{readStateIndex:7987; appliedIndex:7986; }","duration":"102.577999ms","start":"2026-03-05T06:53:48.397233Z","end":"2026-03-05T06:53:48.499811Z","steps":["trace[1791482712] 'read index received'  (duration: 67.348581ms)","trace[1791482712] 'applied index is now lower than readState.Index'  (duration: 35.228128ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T06:53:48.49988Z","caller":"traceutil/trace.go:171","msg":"trace[896327712] transaction","detail":"{read_only:false; response_revision:7699; number_of_response:1; }","duration":"154.804121ms","start":"2026-03-05T06:53:48.345034Z","end":"2026-03-05T06:53:48.499838Z","steps":["trace[896327712] 'process raft request'  (duration: 119.532862ms)","trace[896327712] 'compare'  (duration: 35.055404ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T06:53:48.500253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.988499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-03-05T06:53:48.500367Z","caller":"traceutil/trace.go:171","msg":"trace[2122458791] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7699; }","duration":"103.180133ms","start":"2026-03-05T06:53:48.397161Z","end":"2026-03-05T06:53:48.500341Z","steps":["trace[2122458791] 'agreement among raft nodes before linearized reading'  (duration: 102.787024ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:54:05.163412Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5764}
{"level":"info","ts":"2026-03-05T06:54:05.255435Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5764,"took":"88.776481ms","hash":4120024387,"current-db-size-bytes":43524096,"current-db-size":"44 MB","current-db-size-in-use-bytes":23154688,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-03-05T06:54:05.255513Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4120024387,"revision":5764,"compact-revision":2797}
{"level":"info","ts":"2026-03-05T06:54:16.407154Z","caller":"traceutil/trace.go:171","msg":"trace[83797617] transaction","detail":"{read_only:false; response_revision:7890; number_of_response:1; }","duration":"240.18781ms","start":"2026-03-05T06:54:16.166932Z","end":"2026-03-05T06:54:16.40712Z","steps":["trace[83797617] 'process raft request'  (duration: 239.918894ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:54:19.989248Z","caller":"traceutil/trace.go:171","msg":"trace[759643004] transaction","detail":"{read_only:false; response_revision:7909; number_of_response:1; }","duration":"110.462076ms","start":"2026-03-05T06:54:19.878755Z","end":"2026-03-05T06:54:19.989218Z","steps":["trace[759643004] 'process raft request'  (duration: 110.332253ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:54:30.590411Z","caller":"traceutil/trace.go:171","msg":"trace[1034453298] transaction","detail":"{read_only:false; response_revision:8001; number_of_response:1; }","duration":"110.099467ms","start":"2026-03-05T06:54:30.480278Z","end":"2026-03-05T06:54:30.590378Z","steps":["trace[1034453298] 'process raft request'  (duration: 109.885532ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:54:30.630592Z","caller":"traceutil/trace.go:171","msg":"trace[2135810200] linearizableReadLoop","detail":"{readStateIndex:8304; appliedIndex:8302; }","duration":"128.602568ms","start":"2026-03-05T06:54:30.501958Z","end":"2026-03-05T06:54:30.630561Z","steps":["trace[2135810200] 'read index received'  (duration: 88.210548ms)","trace[2135810200] 'applied index is now lower than readState.Index'  (duration: 40.39055ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T06:54:30.630863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.886204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-03-05T06:54:30.630903Z","caller":"traceutil/trace.go:171","msg":"trace[1649481743] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8002; }","duration":"129.002847ms","start":"2026-03-05T06:54:30.501886Z","end":"2026-03-05T06:54:30.630889Z","steps":["trace[1649481743] 'agreement among raft nodes before linearized reading'  (duration: 128.791442ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:54:30.630974Z","caller":"traceutil/trace.go:171","msg":"trace[250545932] transaction","detail":"{read_only:false; response_revision:8002; number_of_response:1; }","duration":"145.064727ms","start":"2026-03-05T06:54:30.485864Z","end":"2026-03-05T06:54:30.630929Z","steps":["trace[250545932] 'process raft request'  (duration: 144.542265ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:55:47.441586Z","caller":"traceutil/trace.go:171","msg":"trace[728444976] transaction","detail":"{read_only:false; response_revision:8713; number_of_response:1; }","duration":"120.327671ms","start":"2026-03-05T06:55:47.321187Z","end":"2026-03-05T06:55:47.441515Z","steps":["trace[728444976] 'process raft request'  (duration: 120.074365ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:55:47.752002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.41108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T06:55:47.75214Z","caller":"traceutil/trace.go:171","msg":"trace[1476253418] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:8715; }","duration":"165.638125ms","start":"2026-03-05T06:55:47.58647Z","end":"2026-03-05T06:55:47.752108Z","steps":["trace[1476253418] 'count revisions from in-memory index tree'  (duration: 165.262066ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T06:55:47.752615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.369767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-03-05T06:55:47.7527Z","caller":"traceutil/trace.go:171","msg":"trace[1496150192] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:8715; }","duration":"143.49547ms","start":"2026-03-05T06:55:47.609185Z","end":"2026-03-05T06:55:47.75268Z","steps":["trace[1496150192] 'count revisions from in-memory index tree'  (duration: 143.311275ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T06:58:20.059182Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b66d12fd59101739","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-03-05T06:58:20.064923Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-03-05T06:58:20.065043Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-03-05T06:59:05.173465Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7785}
{"level":"info","ts":"2026-03-05T06:59:05.248104Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7785,"took":"71.837346ms","hash":4184719861,"current-db-size-bytes":43524096,"current-db-size":"44 MB","current-db-size-in-use-bytes":25124864,"current-db-size-in-use":"25 MB"}
{"level":"info","ts":"2026-03-05T06:59:05.248375Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4184719861,"revision":7785,"compact-revision":5764}
{"level":"info","ts":"2026-03-05T07:01:07.024977Z","caller":"traceutil/trace.go:171","msg":"trace[586757326] transaction","detail":"{read_only:false; response_revision:10879; number_of_response:1; }","duration":"124.534605ms","start":"2026-03-05T07:01:06.900393Z","end":"2026-03-05T07:01:07.024928Z","steps":["trace[586757326] 'process raft request'  (duration: 124.205517ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T07:01:28.432911Z","caller":"traceutil/trace.go:171","msg":"trace[1461231979] transaction","detail":"{read_only:false; response_revision:10987; number_of_response:1; }","duration":"145.156455ms","start":"2026-03-05T07:01:28.2877Z","end":"2026-03-05T07:01:28.432856Z","steps":["trace[1461231979] 'process raft request'  (duration: 128.192793ms)","trace[1461231979] 'compare'  (duration: 16.648135ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T07:04:05.180174Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9850}
{"level":"info","ts":"2026-03-05T07:04:05.260616Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9850,"took":"76.534173ms","hash":2704253586,"current-db-size-bytes":43524096,"current-db-size":"44 MB","current-db-size-in-use-bytes":22933504,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-03-05T07:04:05.260698Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2704253586,"revision":9850,"compact-revision":7785}
{"level":"info","ts":"2026-03-05T07:06:08.690683Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000033da.wal"}
{"level":"warn","ts":"2026-03-05T07:07:50.930882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.232575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-03-05T07:07:50.930987Z","caller":"traceutil/trace.go:171","msg":"trace[1359270110] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:13406; }","duration":"161.396119ms","start":"2026-03-05T07:07:50.769571Z","end":"2026-03-05T07:07:50.930967Z","steps":["trace[1359270110] 'range keys from in-memory index tree'  (duration: 160.938967ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T07:08:06.378487Z","caller":"traceutil/trace.go:171","msg":"trace[614395274] transaction","detail":"{read_only:false; response_revision:13493; number_of_response:1; }","duration":"120.142345ms","start":"2026-03-05T07:08:06.258304Z","end":"2026-03-05T07:08:06.378446Z","steps":["trace[614395274] 'process raft request'  (duration: 119.864679ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T07:08:06.930212Z","caller":"traceutil/trace.go:171","msg":"trace[509372839] transaction","detail":"{read_only:false; response_revision:13497; number_of_response:1; }","duration":"199.645923ms","start":"2026-03-05T07:08:06.730536Z","end":"2026-03-05T07:08:06.930182Z","steps":["trace[509372839] 'process raft request'  (duration: 199.487689ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T07:08:07.050409Z","caller":"traceutil/trace.go:171","msg":"trace[1797161723] linearizableReadLoop","detail":"{readStateIndex:13995; appliedIndex:13994; }","duration":"116.961781ms","start":"2026-03-05T07:08:06.933429Z","end":"2026-03-05T07:08:07.050391Z","steps":["trace[1797161723] 'read index received'  (duration: 115.331292ms)","trace[1797161723] 'applied index is now lower than readState.Index'  (duration: 1.627318ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T07:08:07.05053Z","caller":"traceutil/trace.go:171","msg":"trace[28325067] transaction","detail":"{read_only:false; response_revision:13498; number_of_response:1; }","duration":"117.342149ms","start":"2026-03-05T07:08:06.933173Z","end":"2026-03-05T07:08:07.050515Z","steps":["trace[28325067] 'process raft request'  (duration: 115.638799ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T07:08:07.05077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.312169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-05T07:08:07.050811Z","caller":"traceutil/trace.go:171","msg":"trace[595399479] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:13498; }","duration":"117.39266ms","start":"2026-03-05T07:08:06.933409Z","end":"2026-03-05T07:08:07.050802Z","steps":["trace[595399479] 'agreement among raft nodes before linearized reading'  (duration: 117.296758ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T07:08:20.603745Z","caller":"traceutil/trace.go:171","msg":"trace[529093206] transaction","detail":"{read_only:false; response_revision:13638; number_of_response:1; }","duration":"172.90143ms","start":"2026-03-05T07:08:20.430797Z","end":"2026-03-05T07:08:20.603699Z","steps":["trace[529093206] 'process raft request'  (duration: 172.587703ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T07:09:05.186041Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":11956}
{"level":"info","ts":"2026-03-05T07:09:05.263219Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":11956,"took":"74.466767ms","hash":357595058,"current-db-size-bytes":43524096,"current-db-size":"44 MB","current-db-size-in-use-bytes":25190400,"current-db-size-in-use":"25 MB"}
{"level":"info","ts":"2026-03-05T07:09:05.263323Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":357595058,"revision":11956,"compact-revision":9850}
{"level":"info","ts":"2026-03-05T07:09:55.460033Z","caller":"traceutil/trace.go:171","msg":"trace[1124523112] transaction","detail":"{read_only:false; response_revision:14575; number_of_response:1; }","duration":"119.560451ms","start":"2026-03-05T07:09:55.340443Z","end":"2026-03-05T07:09:55.460003Z","steps":["trace[1124523112] 'process raft request'  (duration: 119.366147ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T07:09:55.75944Z","caller":"traceutil/trace.go:171","msg":"trace[140396227] linearizableReadLoop","detail":"{readStateIndex:15113; appliedIndex:15111; }","duration":"374.666721ms","start":"2026-03-05T07:09:55.384741Z","end":"2026-03-05T07:09:55.759408Z","steps":["trace[140396227] 'read index received'  (duration: 75.077571ms)","trace[140396227] 'applied index is now lower than readState.Index'  (duration: 299.5875ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T07:09:55.759539Z","caller":"traceutil/trace.go:171","msg":"trace[1240882125] transaction","detail":"{read_only:false; response_revision:14576; number_of_response:1; }","duration":"399.789284ms","start":"2026-03-05T07:09:55.359709Z","end":"2026-03-05T07:09:55.759498Z","steps":["trace[1240882125] 'process raft request'  (duration: 377.283113ms)","trace[1240882125] 'compare'  (duration: 21.998469ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T07:09:55.7597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.939818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"}
{"level":"info","ts":"2026-03-05T07:09:55.759741Z","caller":"traceutil/trace.go:171","msg":"trace[1197134236] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14576; }","duration":"375.035081ms","start":"2026-03-05T07:09:55.384694Z","end":"2026-03-05T07:09:55.759729Z","steps":["trace[1197134236] 'agreement among raft nodes before linearized reading'  (duration: 374.858367ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T07:09:55.759746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T07:09:55.359693Z","time spent":"399.948507ms","remote":"127.0.0.1:38472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:14526 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-03-05T07:09:55.759772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T07:09:55.384677Z","time spent":"375.087032ms","remote":"127.0.0.1:38452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5545,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "}
{"level":"warn","ts":"2026-03-05T07:09:55.759793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.852134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-cx2sc\" ","response":"range_response_count:1 size:22099"}
{"level":"info","ts":"2026-03-05T07:09:55.759907Z","caller":"traceutil/trace.go:171","msg":"trace[858397854] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-cx2sc; range_end:; response_count:1; response_revision:14576; }","duration":"169.008108ms","start":"2026-03-05T07:09:55.590868Z","end":"2026-03-05T07:09:55.759877Z","steps":["trace[858397854] 'agreement among raft nodes before linearized reading'  (duration: 168.740261ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T07:09:55.760173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.720277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T07:09:55.760198Z","caller":"traceutil/trace.go:171","msg":"trace[1536190869] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:14576; }","duration":"128.793599ms","start":"2026-03-05T07:09:55.631397Z","end":"2026-03-05T07:09:55.76019Z","steps":["trace[1536190869] 'agreement among raft nodes before linearized reading'  (duration: 128.755128ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T07:09:55.76027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.469338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"warn","ts":"2026-03-05T07:09:55.760329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.814143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"}
{"level":"info","ts":"2026-03-05T07:09:55.760327Z","caller":"traceutil/trace.go:171","msg":"trace[1402623593] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:14576; }","duration":"146.56969ms","start":"2026-03-05T07:09:55.613743Z","end":"2026-03-05T07:09:55.760312Z","steps":["trace[1402623593] 'agreement among raft nodes before linearized reading'  (duration: 146.426126ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T07:09:55.760354Z","caller":"traceutil/trace.go:171","msg":"trace[1745270061] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14576; }","duration":"126.853615ms","start":"2026-03-05T07:09:55.633491Z","end":"2026-03-05T07:09:55.760345Z","steps":["trace[1745270061] 'agreement among raft nodes before linearized reading'  (duration: 126.793873ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T07:09:55.760409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.394168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-cx2sc\" ","response":"range_response_count:1 size:22099"}
{"level":"warn","ts":"2026-03-05T07:09:55.760451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.885902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T07:09:55.760476Z","caller":"traceutil/trace.go:171","msg":"trace[175220148] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:14576; }","duration":"128.923153ms","start":"2026-03-05T07:09:55.631547Z","end":"2026-03-05T07:09:55.76047Z","steps":["trace[175220148] 'agreement among raft nodes before linearized reading'  (duration: 128.890062ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T07:09:55.76047Z","caller":"traceutil/trace.go:171","msg":"trace[1530937309] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-cx2sc; range_end:; response_count:1; response_revision:14576; }","duration":"166.486369ms","start":"2026-03-05T07:09:55.593968Z","end":"2026-03-05T07:09:55.760454Z","steps":["trace[1530937309] 'agreement among raft nodes before linearized reading'  (duration: 166.261584ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T07:09:55.760612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.077196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T07:09:55.760634Z","caller":"traceutil/trace.go:171","msg":"trace[972087000] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:14576; }","duration":"129.119247ms","start":"2026-03-05T07:09:55.63151Z","end":"2026-03-05T07:09:55.760629Z","steps":["trace[972087000] 'agreement among raft nodes before linearized reading'  (duration: 129.087286ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T07:14:05.193504Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14028}
{"level":"info","ts":"2026-03-05T07:14:05.276766Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14028,"took":"79.809208ms","hash":254753962,"current-db-size-bytes":43524096,"current-db-size":"44 MB","current-db-size-in-use-bytes":31367168,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-03-05T07:14:05.276826Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":254753962,"revision":14028,"compact-revision":11956}
{"level":"info","ts":"2026-03-05T07:19:05.201459Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16363}
{"level":"info","ts":"2026-03-05T07:19:05.304652Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16363,"took":"99.162164ms","hash":4259160864,"current-db-size-bytes":43524096,"current-db-size":"44 MB","current-db-size-in-use-bytes":25354240,"current-db-size-in-use":"25 MB"}
{"level":"info","ts":"2026-03-05T07:19:05.304728Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4259160864,"revision":16363,"compact-revision":14028}