{"level":"warn","ts":"2026-04-14T16:04:54.67738Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-14T16:04:54.677455Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.62: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.62:2380","--initial-cluster=instance=https://162.253.55.62:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.62:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.62: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-04-14T16:04:54.677522Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-14T16:04:54.677537Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.62:2380"]} {"level":"info","ts":"2026-04-14T16:04:54.677554Z","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-04-14T16:04:54.678178Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"]} {"level":"info","ts":"2026-04-14T16:04:54.678251Z","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.62:2380"],"listen-peer-urls":["https://162.253.55.62:2380"],"advertise-client-urls":["https://162.253.55.62:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.62: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-04-14T16:04:54.682703Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.260684ms"} {"level":"info","ts":"2026-04-14T16:04:54.689557Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"791a7e25b533cd26","cluster-id":"be484d2748da72cd"} {"level":"info","ts":"2026-04-14T16:04:54.689695Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=()"} {"level":"info","ts":"2026-04-14T16:04:54.689734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became follower at term 0"} {"level":"info","ts":"2026-04-14T16:04:54.68976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 791a7e25b533cd26 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-14T16:04:54.689779Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became follower at term 1"} {"level":"info","ts":"2026-04-14T16:04:54.689846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=(8726425928402717990)"} {"level":"warn","ts":"2026-04-14T16:04:54.695815Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-14T16:04:54.697209Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-14T16:04:54.698326Z","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-04-14T16:04:54.701161Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"791a7e25b533cd26","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-14T16:04:54.701325Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"791a7e25b533cd26","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-14T16:04:54.701613Z","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-04-14T16:04:54.701737Z","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-04-14T16:04:54.701773Z","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-04-14T16:04:54.703036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=(8726425928402717990)"} {"level":"info","ts":"2026-04-14T16:04:54.70318Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"be484d2748da72cd","local-member-id":"791a7e25b533cd26","added-peer-id":"791a7e25b533cd26","added-peer-peer-urls":["https://162.253.55.62:2380"]} {"level":"info","ts":"2026-04-14T16:04:54.707505Z","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-04-14T16:04:54.70767Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.62:2380"} {"level":"info","ts":"2026-04-14T16:04:54.707737Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.62:2380"} {"level":"info","ts":"2026-04-14T16:04:54.707944Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"791a7e25b533cd26","initial-advertise-peer-urls":["https://162.253.55.62:2380"],"listen-peer-urls":["https://162.253.55.62:2380"],"advertise-client-urls":["https://162.253.55.62:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-14T16:04:54.707998Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-14T16:04:55.390945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 is starting a new election at term 1"} {"level":"info","ts":"2026-04-14T16:04:55.390989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-14T16:04:55.391011Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 received MsgPreVoteResp from 791a7e25b533cd26 at term 1"} {"level":"info","ts":"2026-04-14T16:04:55.391024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became candidate at term 2"} {"level":"info","ts":"2026-04-14T16:04:55.39103Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 received MsgVoteResp from 791a7e25b533cd26 at term 2"} {"level":"info","ts":"2026-04-14T16:04:55.391039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became leader at term 2"} {"level":"info","ts":"2026-04-14T16:04:55.391047Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 791a7e25b533cd26 elected leader 791a7e25b533cd26 at term 2"} {"level":"info","ts":"2026-04-14T16:04:55.392299Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"791a7e25b533cd26","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.62:2379]}","request-path":"/0/members/791a7e25b533cd26/attributes","cluster-id":"be484d2748da72cd","publish-timeout":"7s"} {"level":"info","ts":"2026-04-14T16:04:55.39233Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T16:04:55.392483Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T16:04:55.392547Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T16:04:55.392776Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-14T16:04:55.392885Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-14T16:04:55.393993Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"be484d2748da72cd","local-member-id":"791a7e25b533cd26","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T16:04:55.394113Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T16:04:55.394148Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T16:04:55.394235Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.62:2379"} {"level":"info","ts":"2026-04-14T16:04:55.39746Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-14T16:05:10.316042Z","caller":"traceutil/trace.go:171","msg":"trace[1245196997] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"217.132873ms","start":"2026-04-14T16:05:10.098884Z","end":"2026-04-14T16:05:10.316017Z","steps":["trace[1245196997] 'process raft request' (duration: 216.974169ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:05:31.577694Z","caller":"traceutil/trace.go:171","msg":"trace[1126529163] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:643; }","duration":"212.470206ms","start":"2026-04-14T16:05:31.365193Z","end":"2026-04-14T16:05:31.577663Z","steps":["trace[1126529163] 'read index received' (duration: 212.429935ms)","trace[1126529163] 'applied index is now lower than readState.Index' (duration: 38.951µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T16:05:31.577935Z","caller":"traceutil/trace.go:171","msg":"trace[1818525141] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"426.067873ms","start":"2026-04-14T16:05:31.15184Z","end":"2026-04-14T16:05:31.577907Z","steps":["trace[1818525141] 'process raft request' (duration: 425.680533ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:05:31.57794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.701902ms","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-04-14T16:05:31.578025Z","caller":"traceutil/trace.go:171","msg":"trace[1130313690] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:623; }","duration":"212.856537ms","start":"2026-04-14T16:05:31.365156Z","end":"2026-04-14T16:05:31.578013Z","steps":["trace[1130313690] 'agreement among raft nodes before linearized reading' (duration: 212.617801ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:05:31.578556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T16:05:31.151807Z","time spent":"426.209987ms","remote":"127.0.0.1:40628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T16:06:16.59736Z","caller":"traceutil/trace.go:171","msg":"trace[1964205126] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"127.315499ms","start":"2026-04-14T16:06:16.470017Z","end":"2026-04-14T16:06:16.597332Z","steps":["trace[1964205126] 'process raft request' (duration: 127.133573ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:07:00.576261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.193954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-aecdd640-be14-4c88-9865-e0b0d68c5526\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-14T16:07:00.576363Z","caller":"traceutil/trace.go:171","msg":"trace[757987675] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-aecdd640-be14-4c88-9865-e0b0d68c5526; range_end:; response_count:1; response_revision:1846; }","duration":"368.364238ms","start":"2026-04-14T16:07:00.207976Z","end":"2026-04-14T16:07:00.576341Z","steps":["trace[757987675] 'range keys from in-memory index tree' (duration: 367.968247ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:07:00.576411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T16:07:00.207948Z","time spent":"368.449841ms","remote":"127.0.0.1:40628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-aecdd640-be14-4c88-9865-e0b0d68c5526\" "} {"level":"info","ts":"2026-04-14T16:07:00.599322Z","caller":"traceutil/trace.go:171","msg":"trace[200028279] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"277.503813ms","start":"2026-04-14T16:07:00.32176Z","end":"2026-04-14T16:07:00.599264Z","steps":["trace[200028279] 'process raft request' (duration: 277.181144ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:07:00.914661Z","caller":"traceutil/trace.go:171","msg":"trace[1622016043] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"149.83903ms","start":"2026-04-14T16:07:00.764792Z","end":"2026-04-14T16:07:00.914631Z","steps":["trace[1622016043] 'process raft request' (duration: 135.055592ms)","trace[1622016043] 'compare' (duration: 14.646634ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T16:07:49.846981Z","caller":"traceutil/trace.go:171","msg":"trace[90498038] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"139.326093ms","start":"2026-04-14T16:07:49.707622Z","end":"2026-04-14T16:07:49.846948Z","steps":["trace[90498038] 'process raft request' (duration: 114.955114ms)","trace[90498038] 'compare' (duration: 24.162423ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T16:07:50.389323Z","caller":"traceutil/trace.go:171","msg":"trace[262232243] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"114.871562ms","start":"2026-04-14T16:07:50.274414Z","end":"2026-04-14T16:07:50.389286Z","steps":["trace[262232243] 'process raft request' (duration: 110.368496ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:07:55.774417Z","caller":"traceutil/trace.go:171","msg":"trace[1625542620] transaction","detail":"{read_only:false; response_revision:2193; number_of_response:1; }","duration":"106.377686ms","start":"2026-04-14T16:07:55.668018Z","end":"2026-04-14T16:07:55.774395Z","steps":["trace[1625542620] 'process raft request' (duration: 106.266363ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:07:56.062561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.161801ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T16:07:56.062693Z","caller":"traceutil/trace.go:171","msg":"trace[154367989] transaction","detail":"{read_only:false; response_revision:2194; number_of_response:1; }","duration":"332.786573ms","start":"2026-04-14T16:07:55.729887Z","end":"2026-04-14T16:07:56.062673Z","steps":["trace[154367989] 'process raft request' (duration: 185.042154ms)","trace[154367989] 'compare' (duration: 147.044518ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T16:07:56.062761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T16:07:55.729861Z","time spent":"332.865515ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T16:07:56.072139Z","caller":"traceutil/trace.go:171","msg":"trace[1080212428] transaction","detail":"{read_only:false; response_revision:2195; number_of_response:1; }","duration":"293.200001ms","start":"2026-04-14T16:07:55.778913Z","end":"2026-04-14T16:07:56.072113Z","steps":["trace[1080212428] 'process raft request' (duration: 293.012686ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:07:56.072276Z","caller":"traceutil/trace.go:171","msg":"trace[1368775968] linearizableReadLoop","detail":"{readStateIndex:2276; appliedIndex:2273; }","duration":"191.662351ms","start":"2026-04-14T16:07:55.880587Z","end":"2026-04-14T16:07:56.072249Z","steps":["trace[1368775968] 'read index received' (duration: 34.320844ms)","trace[1368775968] 'applied index is now lower than readState.Index' (duration: 157.339467ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T16:07:56.072331Z","caller":"traceutil/trace.go:171","msg":"trace[594131284] transaction","detail":"{read_only:false; response_revision:2196; number_of_response:1; }","duration":"206.850497ms","start":"2026-04-14T16:07:55.865443Z","end":"2026-04-14T16:07:56.072294Z","steps":["trace[594131284] 'process raft request' (duration: 206.628291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:07:56.072549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.282911ms","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-04-14T16:07:56.072597Z","caller":"traceutil/trace.go:171","msg":"trace[469759111] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2196; }","duration":"175.388223ms","start":"2026-04-14T16:07:55.897196Z","end":"2026-04-14T16:07:56.072584Z","steps":["trace[469759111] 'agreement among raft nodes before linearized reading' (duration: 175.202178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:07:56.072565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.957619ms","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-04-14T16:07:56.072719Z","caller":"traceutil/trace.go:171","msg":"trace[286735622] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2196; }","duration":"192.155294ms","start":"2026-04-14T16:07:55.880539Z","end":"2026-04-14T16:07:56.072694Z","steps":["trace[286735622] 'agreement among raft nodes before linearized reading' (duration: 191.797424ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:07:56.369027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.929994ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T16:07:56.3693Z","caller":"traceutil/trace.go:171","msg":"trace[1514247128] transaction","detail":"{read_only:false; response_revision:2197; number_of_response:1; }","duration":"291.756641ms","start":"2026-04-14T16:07:56.077492Z","end":"2026-04-14T16:07:56.369249Z","steps":["trace[1514247128] 'process raft request' (duration: 133.499438ms)","trace[1514247128] 'compare' (duration: 157.739589ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T16:07:56.3693Z","caller":"traceutil/trace.go:171","msg":"trace[1090315079] transaction","detail":"{read_only:false; response_revision:2198; number_of_response:1; }","duration":"291.544784ms","start":"2026-04-14T16:07:56.077721Z","end":"2026-04-14T16:07:56.369265Z","steps":["trace[1090315079] 'process raft request' (duration: 291.428621ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:07:56.369382Z","caller":"traceutil/trace.go:171","msg":"trace[1368720009] linearizableReadLoop","detail":"{readStateIndex:2278; appliedIndex:2276; }","duration":"269.888677ms","start":"2026-04-14T16:07:56.09947Z","end":"2026-04-14T16:07:56.369358Z","steps":["trace[1368720009] 'read index received' (duration: 111.591733ms)","trace[1368720009] 'applied index is now lower than readState.Index' (duration: 158.293984ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T16:07:56.369494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.01104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T16:07:56.369541Z","caller":"traceutil/trace.go:171","msg":"trace[262731693] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2199; }","duration":"270.099973ms","start":"2026-04-14T16:07:56.099427Z","end":"2026-04-14T16:07:56.369527Z","steps":["trace[262731693] 'agreement among raft nodes before linearized reading' (duration: 270.00064ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:09:05.072552Z","caller":"traceutil/trace.go:171","msg":"trace[946019813] transaction","detail":"{read_only:false; response_revision:2764; number_of_response:1; }","duration":"376.416387ms","start":"2026-04-14T16:09:04.696098Z","end":"2026-04-14T16:09:05.072514Z","steps":["trace[946019813] 'process raft request' (duration: 334.616412ms)","trace[946019813] 'compare' (duration: 41.236745ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T16:09:05.07271Z","caller":"traceutil/trace.go:171","msg":"trace[2140551957] linearizableReadLoop","detail":"{readStateIndex:2866; appliedIndex:2865; }","duration":"372.995413ms","start":"2026-04-14T16:09:04.699675Z","end":"2026-04-14T16:09:05.07267Z","steps":["trace[2140551957] 'read index received' (duration: 331.019471ms)","trace[2140551957] 'applied index is now lower than readState.Index' (duration: 41.948211ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T16:09:05.072996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.251252ms","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-04-14T16:09:05.073095Z","caller":"traceutil/trace.go:171","msg":"trace[922592598] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2764; }","duration":"373.428358ms","start":"2026-04-14T16:09:04.699644Z","end":"2026-04-14T16:09:05.073072Z","steps":["trace[922592598] 'agreement among raft nodes before linearized reading' (duration: 373.117087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:09:05.073101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T16:09:04.69608Z","time spent":"376.572143ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T16:09:05.073161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T16:09:04.699634Z","time spent":"373.515491ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-14T16:09:05.073237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.794932ms","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-04-14T16:09:05.073294Z","caller":"traceutil/trace.go:171","msg":"trace[1085672524] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:2765; }","duration":"309.870945ms","start":"2026-04-14T16:09:04.763408Z","end":"2026-04-14T16:09:05.073279Z","steps":["trace[1085672524] 'agreement among raft nodes before linearized reading' (duration: 309.699599ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:09:05.073339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T16:09:04.763395Z","time spent":"309.933337ms","remote":"127.0.0.1:55906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":15,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-04-14T16:09:05.073352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.690771ms","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-04-14T16:09:05.073491Z","caller":"traceutil/trace.go:171","msg":"trace[387027374] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2765; }","duration":"335.842355ms","start":"2026-04-14T16:09:04.737623Z","end":"2026-04-14T16:09:05.073466Z","steps":["trace[387027374] 'agreement among raft nodes before linearized reading' (duration: 335.593747ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:09:05.073545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T16:09:04.737615Z","time spent":"335.920439ms","remote":"127.0.0.1:40710","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-04-14T16:09:05.073885Z","caller":"traceutil/trace.go:171","msg":"trace[1826514618] transaction","detail":"{read_only:false; response_revision:2765; number_of_response:1; }","duration":"106.231952ms","start":"2026-04-14T16:09:04.966829Z","end":"2026-04-14T16:09:05.073061Z","steps":["trace[1826514618] 'process raft request' (duration: 106.114168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:09:05.073888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.253795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T16:09:05.074243Z","caller":"traceutil/trace.go:171","msg":"trace[1309955710] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:2765; }","duration":"344.426067ms","start":"2026-04-14T16:09:04.7298Z","end":"2026-04-14T16:09:05.074226Z","steps":["trace[1309955710] 'agreement among raft nodes before linearized reading' (duration: 343.226234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:09:05.074314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T16:09:04.729776Z","time spent":"344.50455ms","remote":"127.0.0.1:40550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":30,"response size":30,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"info","ts":"2026-04-14T16:12:51.874072Z","caller":"traceutil/trace.go:171","msg":"trace[1591141059] transaction","detail":"{read_only:false; response_revision:4773; number_of_response:1; }","duration":"131.474438ms","start":"2026-04-14T16:12:51.742559Z","end":"2026-04-14T16:12:51.874033Z","steps":["trace[1591141059] 'process raft request' (duration: 131.220771ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:12:55.999599Z","caller":"traceutil/trace.go:171","msg":"trace[1037951161] transaction","detail":"{read_only:false; response_revision:4925; number_of_response:1; }","duration":"112.342558ms","start":"2026-04-14T16:12:55.887231Z","end":"2026-04-14T16:12:55.999574Z","steps":["trace[1037951161] 'process raft request' (duration: 112.177903ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:12:56.317424Z","caller":"traceutil/trace.go:171","msg":"trace[2033652546] transaction","detail":"{read_only:false; response_revision:4929; number_of_response:1; }","duration":"102.83507ms","start":"2026-04-14T16:12:56.214564Z","end":"2026-04-14T16:12:56.317399Z","steps":["trace[2033652546] 'process raft request' (duration: 102.724387ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:12:56.317436Z","caller":"traceutil/trace.go:171","msg":"trace[1620673794] transaction","detail":"{read_only:false; response_revision:4928; number_of_response:1; }","duration":"102.956323ms","start":"2026-04-14T16:12:56.214457Z","end":"2026-04-14T16:12:56.317413Z","steps":["trace[1620673794] 'process raft request' (duration: 60.948353ms)","trace[1620673794] 'compare' (duration: 41.722252ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T16:13:13.314928Z","caller":"traceutil/trace.go:171","msg":"trace[572255884] transaction","detail":"{read_only:false; response_revision:5293; number_of_response:1; }","duration":"181.790992ms","start":"2026-04-14T16:13:13.133113Z","end":"2026-04-14T16:13:13.314904Z","steps":["trace[572255884] 'process raft request' (duration: 181.649678ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:13:13.542097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.954083ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T16:13:13.542396Z","caller":"traceutil/trace.go:171","msg":"trace[1968202948] transaction","detail":"{read_only:false; response_revision:5294; number_of_response:1; }","duration":"235.358087ms","start":"2026-04-14T16:13:13.306999Z","end":"2026-04-14T16:13:13.542358Z","steps":["trace[1968202948] 'process raft request' (duration: 52.040914ms)","trace[1968202948] 'compare' (duration: 182.83144ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T16:13:13.542423Z","caller":"traceutil/trace.go:171","msg":"trace[1065098012] linearizableReadLoop","detail":"{readStateIndex:5490; appliedIndex:5489; }","duration":"201.354351ms","start":"2026-04-14T16:13:13.341038Z","end":"2026-04-14T16:13:13.542393Z","steps":["trace[1065098012] 'read index received' (duration: 17.988047ms)","trace[1065098012] 'applied index is now lower than readState.Index' (duration: 183.363494ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T16:13:13.542633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.119504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T16:13:13.542679Z","caller":"traceutil/trace.go:171","msg":"trace[1178918901] range","detail":"{range_begin:/registry/monitoring.coreos.com/servicemonitors/; range_end:/registry/monitoring.coreos.com/servicemonitors0; response_count:0; response_revision:5295; }","duration":"111.214417ms","start":"2026-04-14T16:13:13.431454Z","end":"2026-04-14T16:13:13.542668Z","steps":["trace[1178918901] 'agreement among raft nodes before linearized reading' (duration: 111.100434ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:13:13.54366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.593936ms","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-04-14T16:13:13.543819Z","caller":"traceutil/trace.go:171","msg":"trace[1926324536] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5295; }","duration":"202.799132ms","start":"2026-04-14T16:13:13.341001Z","end":"2026-04-14T16:13:13.5438Z","steps":["trace[1926324536] 'agreement among raft nodes before linearized reading' (duration: 201.537656ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:13:13.543683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.324946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2210982"} {"level":"info","ts":"2026-04-14T16:13:13.543976Z","caller":"traceutil/trace.go:171","msg":"trace[20491137] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:5295; }","duration":"187.674517ms","start":"2026-04-14T16:13:13.356276Z","end":"2026-04-14T16:13:13.543951Z","steps":["trace[20491137] 'agreement among raft nodes before linearized reading' (duration: 186.278157ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:13:13.751816Z","caller":"traceutil/trace.go:171","msg":"trace[1335549635] linearizableReadLoop","detail":"{readStateIndex:5493; appliedIndex:5492; }","duration":"119.761378ms","start":"2026-04-14T16:13:13.632015Z","end":"2026-04-14T16:13:13.751776Z","steps":["trace[1335549635] 'read index received' (duration: 42.020242ms)","trace[1335549635] 'applied index is now lower than readState.Index' (duration: 77.740005ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T16:13:13.752015Z","caller":"traceutil/trace.go:171","msg":"trace[2117939976] transaction","detail":"{read_only:false; response_revision:5297; number_of_response:1; }","duration":"120.717854ms","start":"2026-04-14T16:13:13.63126Z","end":"2026-04-14T16:13:13.751978Z","steps":["trace[2117939976] 'process raft request' (duration: 42.776803ms)","trace[2117939976] 'compare' (duration: 77.605842ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T16:13:13.752528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.446626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:80205"} {"level":"info","ts":"2026-04-14T16:13:13.752592Z","caller":"traceutil/trace.go:171","msg":"trace[1546715089] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5297; }","duration":"120.57905ms","start":"2026-04-14T16:13:13.631996Z","end":"2026-04-14T16:13:13.752575Z","steps":["trace[1546715089] 'agreement among raft nodes before linearized reading' (duration: 120.024574ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:13:13.752943Z","caller":"traceutil/trace.go:171","msg":"trace[697470221] transaction","detail":"{read_only:false; response_revision:5298; number_of_response:1; }","duration":"117.768711ms","start":"2026-04-14T16:13:13.63515Z","end":"2026-04-14T16:13:13.752918Z","steps":["trace[697470221] 'process raft request' (duration: 117.598357ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:14:55.425917Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3043} {"level":"info","ts":"2026-04-14T16:14:55.512602Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3043,"took":"84.147179ms","hash":3890691081,"current-db-size-bytes":58986496,"current-db-size":"59 MB","current-db-size-in-use-bytes":32411648,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-14T16:14:55.512697Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3890691081,"revision":3043,"compact-revision":-1} {"level":"warn","ts":"2026-04-14T16:17:07.729102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.174676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-14T16:17:07.729191Z","caller":"traceutil/trace.go:171","msg":"trace[1300204929] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7035; }","duration":"201.31442ms","start":"2026-04-14T16:17:07.527859Z","end":"2026-04-14T16:17:07.729173Z","steps":["trace[1300204929] 'range keys from in-memory index tree' (duration: 200.992121ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:17:07.729143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.067366ms","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-04-14T16:17:07.729345Z","caller":"traceutil/trace.go:171","msg":"trace[1887109990] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7035; }","duration":"198.299723ms","start":"2026-04-14T16:17:07.531025Z","end":"2026-04-14T16:17:07.729325Z","steps":["trace[1887109990] 'range keys from in-memory index tree' (duration: 197.950073ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:17:08.72477Z","caller":"traceutil/trace.go:171","msg":"trace[1676204951] linearizableReadLoop","detail":"{readStateIndex:7290; appliedIndex:7289; }","duration":"369.399285ms","start":"2026-04-14T16:17:08.355315Z","end":"2026-04-14T16:17:08.724714Z","steps":["trace[1676204951] 'read index received' (duration: 369.098676ms)","trace[1676204951] 'applied index is now lower than readState.Index' (duration: 299.159µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T16:17:08.724982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.649922ms","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-04-14T16:17:08.724971Z","caller":"traceutil/trace.go:171","msg":"trace[373429449] transaction","detail":"{read_only:false; response_revision:7038; number_of_response:1; }","duration":"419.914026ms","start":"2026-04-14T16:17:08.304939Z","end":"2026-04-14T16:17:08.724853Z","steps":["trace[373429449] 'process raft request' (duration: 419.496154ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:17:08.725043Z","caller":"traceutil/trace.go:171","msg":"trace[1811787520] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:7038; }","duration":"369.775385ms","start":"2026-04-14T16:17:08.355252Z","end":"2026-04-14T16:17:08.725027Z","steps":["trace[1811787520] 'agreement among raft nodes before linearized reading' (duration: 369.658622ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:17:08.725276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T16:17:08.355226Z","time spent":"370.031643ms","remote":"127.0.0.1:36882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-04-14T16:17:08.725215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T16:17:08.304914Z","time spent":"420.206143ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T16:17:08.728317Z","caller":"traceutil/trace.go:171","msg":"trace[1019865591] transaction","detail":"{read_only:false; response_revision:7039; number_of_response:1; }","duration":"358.586574ms","start":"2026-04-14T16:17:08.369677Z","end":"2026-04-14T16:17:08.728263Z","steps":["trace[1019865591] 'process raft request' (duration: 358.43828ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:17:08.728441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.111392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-barbican\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-04-14T16:17:08.728491Z","caller":"traceutil/trace.go:171","msg":"trace[1814585734] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-barbican; range_end:; response_count:1; response_revision:7040; }","duration":"171.190844ms","start":"2026-04-14T16:17:08.557286Z","end":"2026-04-14T16:17:08.728477Z","steps":["trace[1814585734] 'agreement among raft nodes before linearized reading' (duration: 171.101982ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:17:08.728541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.918857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T16:17:08.728619Z","caller":"traceutil/trace.go:171","msg":"trace[407601247] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:7040; }","duration":"333.038371ms","start":"2026-04-14T16:17:08.395561Z","end":"2026-04-14T16:17:08.728599Z","steps":["trace[407601247] 'agreement among raft nodes before linearized reading' (duration: 332.918067ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:17:08.728359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.963139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.62\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-04-14T16:17:08.728674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T16:17:08.39554Z","time spent":"333.118673ms","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-04-14T16:17:08.728515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T16:17:08.369653Z","time spent":"358.75832ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T16:17:08.728715Z","caller":"traceutil/trace.go:171","msg":"trace[359087376] range","detail":"{range_begin:/registry/masterleases/162.253.55.62; range_end:; response_count:1; response_revision:7040; }","duration":"341.366341ms","start":"2026-04-14T16:17:08.387336Z","end":"2026-04-14T16:17:08.728703Z","steps":["trace[359087376] 'agreement among raft nodes before linearized reading' (duration: 340.903897ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:17:08.729047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T16:17:08.387305Z","time spent":"341.658469ms","remote":"127.0.0.1:40484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/162.253.55.62\" "} {"level":"info","ts":"2026-04-14T16:17:08.728574Z","caller":"traceutil/trace.go:171","msg":"trace[1323758501] transaction","detail":"{read_only:false; response_revision:7040; number_of_response:1; }","duration":"352.50575ms","start":"2026-04-14T16:17:08.375874Z","end":"2026-04-14T16:17:08.72838Z","steps":["trace[1323758501] 'process raft request' (duration: 352.324824ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:17:08.729237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T16:17:08.375852Z","time spent":"353.325423ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T16:18:28.502151Z","caller":"traceutil/trace.go:171","msg":"trace[1328861611] linearizableReadLoop","detail":"{readStateIndex:7927; appliedIndex:7926; }","duration":"383.119356ms","start":"2026-04-14T16:18:28.119013Z","end":"2026-04-14T16:18:28.502133Z","steps":["trace[1328861611] 'read index received' (duration: 382.948291ms)","trace[1328861611] 'applied index is now lower than readState.Index' (duration: 170.235µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T16:18:28.502441Z","caller":"traceutil/trace.go:171","msg":"trace[1755851148] transaction","detail":"{read_only:false; response_revision:7657; number_of_response:1; }","duration":"390.300059ms","start":"2026-04-14T16:18:28.112126Z","end":"2026-04-14T16:18:28.502426Z","steps":["trace[1755851148] 'process raft request' (duration: 389.898058ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:18:28.502625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T16:18:28.112114Z","time spent":"390.415772ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T16:18:28.502943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.919288ms","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-04-14T16:18:28.502997Z","caller":"traceutil/trace.go:171","msg":"trace[1535747667] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7657; }","duration":"383.9845ms","start":"2026-04-14T16:18:28.118997Z","end":"2026-04-14T16:18:28.502982Z","steps":["trace[1535747667] 'agreement among raft nodes before linearized reading' (duration: 383.845556ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:18:28.50307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T16:18:28.118991Z","time spent":"384.067812ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-14T16:18:28.503345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.464294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.62\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-14T16:18:28.503383Z","caller":"traceutil/trace.go:171","msg":"trace[616831712] range","detail":"{range_begin:/registry/masterleases/162.253.55.62; range_end:; response_count:1; response_revision:7657; }","duration":"113.542336ms","start":"2026-04-14T16:18:28.389831Z","end":"2026-04-14T16:18:28.503374Z","steps":["trace[616831712] 'agreement among raft nodes before linearized reading' (duration: 113.442653ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:18:29.092261Z","caller":"traceutil/trace.go:171","msg":"trace[1011678978] transaction","detail":"{read_only:false; response_revision:7660; number_of_response:1; }","duration":"107.431274ms","start":"2026-04-14T16:18:28.984805Z","end":"2026-04-14T16:18:29.092236Z","steps":["trace[1011678978] 'process raft request' (duration: 107.161005ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:18:29.093275Z","caller":"traceutil/trace.go:171","msg":"trace[1964787879] transaction","detail":"{read_only:false; response_revision:7661; number_of_response:1; }","duration":"108.085741ms","start":"2026-04-14T16:18:28.985168Z","end":"2026-04-14T16:18:29.093254Z","steps":["trace[1964787879] 'process raft request' (duration: 107.993249ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:18:29.566343Z","caller":"traceutil/trace.go:171","msg":"trace[1841536187] transaction","detail":"{read_only:false; response_revision:7663; number_of_response:1; }","duration":"196.822112ms","start":"2026-04-14T16:18:29.369499Z","end":"2026-04-14T16:18:29.566321Z","steps":["trace[1841536187] 'process raft request' (duration: 196.75943ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:18:29.566584Z","caller":"traceutil/trace.go:171","msg":"trace[167765689] linearizableReadLoop","detail":"{readStateIndex:7933; appliedIndex:7932; }","duration":"364.025434ms","start":"2026-04-14T16:18:29.202539Z","end":"2026-04-14T16:18:29.566565Z","steps":["trace[167765689] 'read index received' (duration: 362.268513ms)","trace[167765689] 'applied index is now lower than readState.Index' (duration: 1.754451ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T16:18:29.567505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.466393ms","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-04-14T16:18:29.567558Z","caller":"traceutil/trace.go:171","msg":"trace[266177755] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7663; }","duration":"353.555005ms","start":"2026-04-14T16:18:29.213988Z","end":"2026-04-14T16:18:29.567543Z","steps":["trace[266177755] 'agreement among raft nodes before linearized reading' (duration: 353.37068ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:18:29.567592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T16:18:29.213976Z","time spent":"353.607757ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-14T16:18:29.567964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.401589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-d68jf\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-04-14T16:18:29.568006Z","caller":"traceutil/trace.go:171","msg":"trace[2146008387] range","detail":"{range_begin:/registry/pods/openstack/keepalived-d68jf; range_end:; response_count:1; response_revision:7663; }","duration":"102.471681ms","start":"2026-04-14T16:18:29.465524Z","end":"2026-04-14T16:18:29.567995Z","steps":["trace[2146008387] 'agreement among raft nodes before linearized reading' (duration: 102.343757ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:18:29.568232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.989891ms","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-04-14T16:18:29.568407Z","caller":"traceutil/trace.go:171","msg":"trace[274218766] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7663; }","duration":"365.879737ms","start":"2026-04-14T16:18:29.202506Z","end":"2026-04-14T16:18:29.568385Z","steps":["trace[274218766] 'agreement among raft nodes before linearized reading' (duration: 364.718973ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:18:29.568556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T16:18:29.202493Z","time spent":"366.042531ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-14T16:18:29.566499Z","caller":"traceutil/trace.go:171","msg":"trace[59338495] transaction","detail":"{read_only:false; response_revision:7662; number_of_response:1; }","duration":"383.065304ms","start":"2026-04-14T16:18:29.183422Z","end":"2026-04-14T16:18:29.566487Z","steps":["trace[59338495] 'process raft request' (duration: 381.262443ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:18:29.56946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T16:18:29.1834Z","time spent":"385.914646ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T16:18:36.366008Z","caller":"traceutil/trace.go:171","msg":"trace[1182920657] transaction","detail":"{read_only:false; response_revision:7713; number_of_response:1; }","duration":"134.818441ms","start":"2026-04-14T16:18:36.231163Z","end":"2026-04-14T16:18:36.365982Z","steps":["trace[1182920657] 'process raft request' (duration: 134.676097ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:18:36.729428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.297261ms","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-04-14T16:18:36.729513Z","caller":"traceutil/trace.go:171","msg":"trace[2136385313] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7714; }","duration":"125.414374ms","start":"2026-04-14T16:18:36.60408Z","end":"2026-04-14T16:18:36.729494Z","steps":["trace[2136385313] 'range keys from in-memory index tree' (duration: 125.221459ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:18:36.72974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.950275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-14T16:18:36.729831Z","caller":"traceutil/trace.go:171","msg":"trace[452563756] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7714; }","duration":"185.13966ms","start":"2026-04-14T16:18:36.544672Z","end":"2026-04-14T16:18:36.729811Z","steps":["trace[452563756] 'range keys from in-memory index tree' (duration: 184.77195ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:19:21.167147Z","caller":"traceutil/trace.go:171","msg":"trace[1612252606] transaction","detail":"{read_only:false; response_revision:8133; number_of_response:1; }","duration":"205.836941ms","start":"2026-04-14T16:19:20.961275Z","end":"2026-04-14T16:19:21.167112Z","steps":["trace[1612252606] 'process raft request' (duration: 205.617835ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:19:21.291006Z","caller":"traceutil/trace.go:171","msg":"trace[1470072049] transaction","detail":"{read_only:false; response_revision:8134; number_of_response:1; }","duration":"327.253284ms","start":"2026-04-14T16:19:20.963716Z","end":"2026-04-14T16:19:21.290969Z","steps":["trace[1470072049] 'process raft request' (duration: 280.042471ms)","trace[1470072049] 'compare' (duration: 47.076239ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T16:19:21.291167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T16:19:20.963699Z","time spent":"327.385557ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T16:19:21.291028Z","caller":"traceutil/trace.go:171","msg":"trace[2082630272] linearizableReadLoop","detail":"{readStateIndex:8419; appliedIndex:8417; }","duration":"190.816825ms","start":"2026-04-14T16:19:21.100184Z","end":"2026-04-14T16:19:21.291001Z","steps":["trace[2082630272] 'read index received' (duration: 66.810649ms)","trace[2082630272] 'applied index is now lower than readState.Index' (duration: 124.004846ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T16:19:21.291365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.979939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T16:19:21.291441Z","caller":"traceutil/trace.go:171","msg":"trace[2108235017] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8134; }","duration":"191.301898ms","start":"2026-04-14T16:19:21.100117Z","end":"2026-04-14T16:19:21.291419Z","steps":["trace[2108235017] 'agreement among raft nodes before linearized reading' (duration: 190.98841ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:19:55.431822Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6203} {"level":"info","ts":"2026-04-14T16:19:55.530663Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6203,"took":"97.112791ms","hash":200162491,"current-db-size-bytes":58986496,"current-db-size":"59 MB","current-db-size-in-use-bytes":22970368,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-14T16:19:55.53078Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":200162491,"revision":6203,"compact-revision":3043} {"level":"info","ts":"2026-04-14T16:20:02.246348Z","caller":"traceutil/trace.go:171","msg":"trace[1553757599] transaction","detail":"{read_only:false; response_revision:8407; number_of_response:1; }","duration":"261.742939ms","start":"2026-04-14T16:20:01.984581Z","end":"2026-04-14T16:20:02.246324Z","steps":["trace[1553757599] 'process raft request' (duration: 261.573285ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:20:02.421002Z","caller":"traceutil/trace.go:171","msg":"trace[190580836] linearizableReadLoop","detail":"{readStateIndex:8705; appliedIndex:8703; }","duration":"334.419738ms","start":"2026-04-14T16:20:02.086552Z","end":"2026-04-14T16:20:02.420972Z","steps":["trace[190580836] 'read index received' (duration: 159.594515ms)","trace[190580836] 'applied index is now lower than readState.Index' (duration: 174.823993ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T16:20:02.421466Z","caller":"traceutil/trace.go:171","msg":"trace[1933194158] transaction","detail":"{read_only:false; response_revision:8408; number_of_response:1; }","duration":"415.690874ms","start":"2026-04-14T16:20:02.005739Z","end":"2026-04-14T16:20:02.42143Z","steps":["trace[1933194158] 'process raft request' (duration: 367.635197ms)","trace[1933194158] 'compare' (duration: 47.43417ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T16:20:02.421527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.830894ms","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":"warn","ts":"2026-04-14T16:20:02.42156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.989402ms","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-04-14T16:20:02.421615Z","caller":"traceutil/trace.go:171","msg":"trace[545280083] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8408; }","duration":"304.935767ms","start":"2026-04-14T16:20:02.116659Z","end":"2026-04-14T16:20:02.421595Z","steps":["trace[545280083] 'agreement among raft nodes before linearized reading' (duration: 304.693521ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:20:02.421631Z","caller":"traceutil/trace.go:171","msg":"trace[774014836] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8408; }","duration":"335.099146ms","start":"2026-04-14T16:20:02.086514Z","end":"2026-04-14T16:20:02.421613Z","steps":["trace[774014836] 'agreement among raft nodes before linearized reading' (duration: 334.87874ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:20:02.421635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T16:20:02.005713Z","time spent":"415.835648ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T16:20:02.421627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.459127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-d68jf\" ","response":"range_response_count:1 size:6527"} {"level":"warn","ts":"2026-04-14T16:20:02.421667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T16:20:02.116595Z","time spent":"305.063001ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-14T16:20:02.421679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T16:20:02.086499Z","time spent":"335.169627ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-14T16:20:02.421707Z","caller":"traceutil/trace.go:171","msg":"trace[1454697142] range","detail":"{range_begin:/registry/pods/openstack/keepalived-d68jf; range_end:; response_count:1; response_revision:8408; }","duration":"247.574411ms","start":"2026-04-14T16:20:02.174114Z","end":"2026-04-14T16:20:02.421688Z","steps":["trace[1454697142] 'agreement among raft nodes before linearized reading' (duration: 247.314444ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:20:04.688288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.313478ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T16:20:04.688554Z","caller":"traceutil/trace.go:171","msg":"trace[2077742931] transaction","detail":"{read_only:false; response_revision:8421; number_of_response:1; }","duration":"249.04668ms","start":"2026-04-14T16:20:04.439485Z","end":"2026-04-14T16:20:04.688531Z","steps":["trace[2077742931] 'process raft request' (duration: 248.913606ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:20:04.688632Z","caller":"traceutil/trace.go:171","msg":"trace[1858163361] transaction","detail":"{read_only:false; response_revision:8420; number_of_response:1; }","duration":"249.208904ms","start":"2026-04-14T16:20:04.4394Z","end":"2026-04-14T16:20:04.688609Z","steps":["trace[1858163361] 'process raft request' (duration: 133.473335ms)","trace[1858163361] 'compare' (duration: 115.195035ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T16:20:14.471791Z","caller":"traceutil/trace.go:171","msg":"trace[435261514] transaction","detail":"{read_only:false; response_revision:8512; number_of_response:1; }","duration":"120.488207ms","start":"2026-04-14T16:20:14.351261Z","end":"2026-04-14T16:20:14.471749Z","steps":["trace[435261514] 'process raft request' (duration: 115.358491ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:20:14.476497Z","caller":"traceutil/trace.go:171","msg":"trace[24114910] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8513; }","duration":"122.994384ms","start":"2026-04-14T16:20:14.353483Z","end":"2026-04-14T16:20:14.476477Z","steps":["trace[24114910] 'process raft request' (duration: 122.912622ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:20:15.530277Z","caller":"traceutil/trace.go:171","msg":"trace[1803236307] transaction","detail":"{read_only:false; response_revision:8521; number_of_response:1; }","duration":"115.626297ms","start":"2026-04-14T16:20:15.414622Z","end":"2026-04-14T16:20:15.530248Z","steps":["trace[1803236307] 'process raft request' (duration: 115.36764ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:20:15.745806Z","caller":"traceutil/trace.go:171","msg":"trace[1866111692] linearizableReadLoop","detail":"{readStateIndex:8826; appliedIndex:8824; }","duration":"208.36858ms","start":"2026-04-14T16:20:15.537413Z","end":"2026-04-14T16:20:15.745781Z","steps":["trace[1866111692] 'read index received' (duration: 19.472572ms)","trace[1866111692] 'applied index is now lower than readState.Index' (duration: 188.894738ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T16:20:15.745946Z","caller":"traceutil/trace.go:171","msg":"trace[571280820] transaction","detail":"{read_only:false; response_revision:8524; number_of_response:1; }","duration":"196.074361ms","start":"2026-04-14T16:20:15.549856Z","end":"2026-04-14T16:20:15.745931Z","steps":["trace[571280820] 'process raft request' (duration: 195.870416ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:20:15.745992Z","caller":"traceutil/trace.go:171","msg":"trace[1932772271] transaction","detail":"{read_only:false; response_revision:8523; number_of_response:1; }","duration":"212.333107ms","start":"2026-04-14T16:20:15.533551Z","end":"2026-04-14T16:20:15.745884Z","steps":["trace[1932772271] 'process raft request' (duration: 168.282568ms)","trace[1932772271] 'compare' (duration: 43.661839ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T16:20:15.746081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.656808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-config-override\" ","response":"range_response_count:1 size:626"} {"level":"info","ts":"2026-04-14T16:20:15.74615Z","caller":"traceutil/trace.go:171","msg":"trace[1374426090] range","detail":"{range_begin:/registry/configmaps/openstack/rook-config-override; range_end:; response_count:1; response_revision:8524; }","duration":"208.764061ms","start":"2026-04-14T16:20:15.53737Z","end":"2026-04-14T16:20:15.746134Z","steps":["trace[1374426090] 'agreement among raft nodes before linearized reading' (duration: 208.568026ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:20:15.746142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.548395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-14T16:20:15.746228Z","caller":"traceutil/trace.go:171","msg":"trace[1636669920] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8524; }","duration":"146.682679ms","start":"2026-04-14T16:20:15.599528Z","end":"2026-04-14T16:20:15.74621Z","steps":["trace[1636669920] 'agreement among raft nodes before linearized reading' (duration: 146.425502ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:21:00.28091Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002419.wal"} {"level":"info","ts":"2026-04-14T16:21:31.480573Z","caller":"traceutil/trace.go:171","msg":"trace[1622860361] transaction","detail":"{read_only:false; response_revision:9266; number_of_response:1; }","duration":"229.576014ms","start":"2026-04-14T16:21:31.250971Z","end":"2026-04-14T16:21:31.480547Z","steps":["trace[1622860361] 'process raft request' (duration: 221.178985ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:21:38.431544Z","caller":"traceutil/trace.go:171","msg":"trace[1659704585] transaction","detail":"{read_only:false; response_revision:9320; number_of_response:1; }","duration":"581.705985ms","start":"2026-04-14T16:21:37.849807Z","end":"2026-04-14T16:21:38.431513Z","steps":["trace[1659704585] 'process raft request' (duration: 581.478509ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:21:38.431822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T16:21:37.849781Z","time spent":"581.951482ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T16:21:38.432492Z","caller":"traceutil/trace.go:171","msg":"trace[1633120368] linearizableReadLoop","detail":"{readStateIndex:9645; appliedIndex:9643; }","duration":"281.944725ms","start":"2026-04-14T16:21:38.150514Z","end":"2026-04-14T16:21:38.432459Z","steps":["trace[1633120368] 'read index received' (duration: 280.888394ms)","trace[1633120368] 'applied index is now lower than readState.Index' (duration: 1.055191ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T16:21:38.432573Z","caller":"traceutil/trace.go:171","msg":"trace[2013332117] transaction","detail":"{read_only:false; response_revision:9321; number_of_response:1; }","duration":"422.133884ms","start":"2026-04-14T16:21:38.010424Z","end":"2026-04-14T16:21:38.432558Z","steps":["trace[2013332117] 'process raft request' (duration: 421.884476ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:21:38.432737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T16:21:38.010386Z","time spent":"422.306579ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T16:21:38.432891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.357867ms","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-04-14T16:21:38.432922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.314295ms","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-04-14T16:21:38.43296Z","caller":"traceutil/trace.go:171","msg":"trace[774054809] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9321; }","duration":"282.4842ms","start":"2026-04-14T16:21:38.150457Z","end":"2026-04-14T16:21:38.432941Z","steps":["trace[774054809] 'agreement among raft nodes before linearized reading' (duration: 282.203482ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:21:38.433014Z","caller":"traceutil/trace.go:171","msg":"trace[797248784] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9321; }","duration":"282.47262ms","start":"2026-04-14T16:21:38.150519Z","end":"2026-04-14T16:21:38.432992Z","steps":["trace[797248784] 'agreement among raft nodes before linearized reading' (duration: 282.239183ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T16:21:38.433027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.289067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T16:21:38.433159Z","caller":"traceutil/trace.go:171","msg":"trace[731874166] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:9321; }","duration":"137.480102ms","start":"2026-04-14T16:21:38.295646Z","end":"2026-04-14T16:21:38.433126Z","steps":["trace[731874166] 'agreement among raft nodes before linearized reading' (duration: 137.252606ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:22:26.749269Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"791a7e25b533cd26","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-14T16:22:26.756172Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-14T16:22:26.756272Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-14T16:23:46.980706Z","caller":"traceutil/trace.go:171","msg":"trace[1402043578] transaction","detail":"{read_only:false; response_revision:10295; number_of_response:1; }","duration":"116.416187ms","start":"2026-04-14T16:23:46.864245Z","end":"2026-04-14T16:23:46.980662Z","steps":["trace[1402043578] 'process raft request' (duration: 116.18968ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:23:46.984437Z","caller":"traceutil/trace.go:171","msg":"trace[294558273] transaction","detail":"{read_only:false; response_revision:10296; number_of_response:1; }","duration":"119.999039ms","start":"2026-04-14T16:23:46.864408Z","end":"2026-04-14T16:23:46.984407Z","steps":["trace[294558273] 'process raft request' (duration: 119.401682ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T16:24:55.437199Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8323} {"level":"info","ts":"2026-04-14T16:24:55.513733Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8323,"took":"74.208844ms","hash":705576117,"current-db-size-bytes":58986496,"current-db-size":"59 MB","current-db-size-in-use-bytes":24866816,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-14T16:24:55.513805Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":705576117,"revision":8323,"compact-revision":6203} {"level":"info","ts":"2026-04-14T16:29:55.44293Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10716} {"level":"info","ts":"2026-04-14T16:29:55.515083Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10716,"took":"70.450321ms","hash":4265149026,"current-db-size-bytes":58986496,"current-db-size":"59 MB","current-db-size-in-use-bytes":20373504,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-14T16:29:55.515126Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4265149026,"revision":10716,"compact-revision":8323}