{"level":"warn","ts":"2026-04-07T00:03:19.759415Z","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-07T00:03:19.759534Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.209:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.209:2380","--initial-cluster=instance=https://199.19.213.209:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.209:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.209: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-07T00:03:19.759626Z","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-07T00:03:19.759645Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.209:2380"]}
{"level":"info","ts":"2026-04-07T00:03:19.759822Z","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-07T00:03:19.760584Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.209:2379"]}
{"level":"info","ts":"2026-04-07T00:03:19.76067Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.209:2380"],"listen-peer-urls":["https://199.19.213.209:2380"],"advertise-client-urls":["https://199.19.213.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.209: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-07T00:03:19.984361Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"223.076584ms"}
{"level":"info","ts":"2026-04-07T00:03:20.424769Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9409e054be1d0d72","cluster-id":"ff5f9c0688884e7d"}
{"level":"info","ts":"2026-04-07T00:03:20.424909Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 switched to configuration voters=()"}
{"level":"info","ts":"2026-04-07T00:03:20.424937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 became follower at term 0"}
{"level":"info","ts":"2026-04-07T00:03:20.424951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9409e054be1d0d72 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-07T00:03:20.42496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 became follower at term 1"}
{"level":"info","ts":"2026-04-07T00:03:20.425022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 switched to configuration voters=(10667303846975180146)"}
{"level":"warn","ts":"2026-04-07T00:03:20.601049Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-07T00:03:20.602973Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-07T00:03:20.604608Z","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-07T00:03:20.607521Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9409e054be1d0d72","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-07T00:03:20.608753Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9409e054be1d0d72","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-07T00:03:20.608933Z","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-07T00:03:20.609074Z","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-07T00:03:20.609102Z","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-07T00:03:20.610555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 switched to configuration voters=(10667303846975180146)"}
{"level":"info","ts":"2026-04-07T00:03:20.610751Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ff5f9c0688884e7d","local-member-id":"9409e054be1d0d72","added-peer-id":"9409e054be1d0d72","added-peer-peer-urls":["https://199.19.213.209:2380"]}
{"level":"info","ts":"2026-04-07T00:03:20.61386Z","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-07T00:03:20.614081Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.209:2380"}
{"level":"info","ts":"2026-04-07T00:03:20.614151Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.209:2380"}
{"level":"info","ts":"2026-04-07T00:03:20.614345Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9409e054be1d0d72","initial-advertise-peer-urls":["https://199.19.213.209:2380"],"listen-peer-urls":["https://199.19.213.209:2380"],"advertise-client-urls":["https://199.19.213.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-07T00:03:20.614389Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-07T00:03:20.625863Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 is starting a new election at term 1"}
{"level":"info","ts":"2026-04-07T00:03:20.625906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-07T00:03:20.625933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 received MsgPreVoteResp from 9409e054be1d0d72 at term 1"}
{"level":"info","ts":"2026-04-07T00:03:20.625965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 became candidate at term 2"}
{"level":"info","ts":"2026-04-07T00:03:20.626025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 received MsgVoteResp from 9409e054be1d0d72 at term 2"}
{"level":"info","ts":"2026-04-07T00:03:20.626043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9409e054be1d0d72 became leader at term 2"}
{"level":"info","ts":"2026-04-07T00:03:20.626118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9409e054be1d0d72 elected leader 9409e054be1d0d72 at term 2"}
{"level":"info","ts":"2026-04-07T00:03:20.627013Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9409e054be1d0d72","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.209:2379]}","request-path":"/0/members/9409e054be1d0d72/attributes","cluster-id":"ff5f9c0688884e7d","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-07T00:03:20.627244Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-07T00:03:20.627322Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-07T00:03:20.627407Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-07T00:03:20.627464Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-07T00:03:20.627529Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-07T00:03:20.628397Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ff5f9c0688884e7d","local-member-id":"9409e054be1d0d72","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-07T00:03:20.628605Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-07T00:03:20.628635Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-07T00:03:20.633753Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.209:2379"}
{"level":"info","ts":"2026-04-07T00:03:20.633912Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-07T00:03:56.722447Z","caller":"traceutil/trace.go:171","msg":"trace[1516146524] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"228.674092ms","start":"2026-04-07T00:03:56.493747Z","end":"2026-04-07T00:03:56.722421Z","steps":["trace[1516146524] 'read index received'  (duration: 228.001328ms)","trace[1516146524] 'applied index is now lower than readState.Index'  (duration: 671.854µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-07T00:03:56.722686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.896307ms","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-07T00:03:56.722901Z","caller":"traceutil/trace.go:171","msg":"trace[125730691] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:615; }","duration":"229.166652ms","start":"2026-04-07T00:03:56.493712Z","end":"2026-04-07T00:03:56.722879Z","steps":["trace[125730691] 'agreement among raft nodes before linearized reading'  (duration: 228.789225ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:03:56.723085Z","caller":"traceutil/trace.go:171","msg":"trace[1298517074] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"232.617072ms","start":"2026-04-07T00:03:56.490442Z","end":"2026-04-07T00:03:56.723059Z","steps":["trace[1298517074] 'process raft request'  (duration: 231.471048ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:03:56.754445Z","caller":"traceutil/trace.go:171","msg":"trace[1916103106] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"249.501763ms","start":"2026-04-07T00:03:56.504917Z","end":"2026-04-07T00:03:56.754419Z","steps":["trace[1916103106] 'process raft request'  (duration: 249.389981ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:03:56.754938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.861337ms","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-07T00:03:56.754985Z","caller":"traceutil/trace.go:171","msg":"trace[1373655356] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:616; }","duration":"191.960659ms","start":"2026-04-07T00:03:56.563012Z","end":"2026-04-07T00:03:56.754973Z","steps":["trace[1373655356] 'agreement among raft nodes before linearized reading'  (duration: 191.645633ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:03:57.054205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.303135ms","expected-duration":"100ms","prefix":"","request":"header:<ID:969009928032677404 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:599 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-07T00:03:57.054569Z","caller":"traceutil/trace.go:171","msg":"trace[1844514062] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"327.319587ms","start":"2026-04-07T00:03:56.727209Z","end":"2026-04-07T00:03:57.054529Z","steps":["trace[1844514062] 'process raft request'  (duration: 144.153635ms)","trace[1844514062] 'compare'  (duration: 182.129111ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:03:57.05466Z","caller":"traceutil/trace.go:171","msg":"trace[1105301987] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"296.976754ms","start":"2026-04-07T00:03:56.757647Z","end":"2026-04-07T00:03:57.054624Z","steps":["trace[1105301987] 'process raft request'  (duration: 296.651817ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:03:57.054692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:03:56.727191Z","time spent":"327.447859ms","remote":"127.0.0.1:48856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:599 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-04-07T00:03:57.055188Z","caller":"traceutil/trace.go:171","msg":"trace[705149325] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:639; }","duration":"137.868247ms","start":"2026-04-07T00:03:56.917307Z","end":"2026-04-07T00:03:57.055175Z","steps":["trace[705149325] 'read index received'  (duration: 136.04515ms)","trace[705149325] 'applied index is now lower than readState.Index'  (duration: 1.822357ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:03:57.055246Z","caller":"traceutil/trace.go:171","msg":"trace[895720273] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"293.929432ms","start":"2026-04-07T00:03:56.761293Z","end":"2026-04-07T00:03:57.055222Z","steps":["trace[895720273] 'process raft request'  (duration: 293.077835ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:03:57.055286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.969899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-07T00:03:57.055324Z","caller":"traceutil/trace.go:171","msg":"trace[1829782867] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"138.0442ms","start":"2026-04-07T00:03:56.917268Z","end":"2026-04-07T00:03:57.055312Z","steps":["trace[1829782867] 'agreement among raft nodes before linearized reading'  (duration: 137.963259ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:03:57.055623Z","caller":"traceutil/trace.go:171","msg":"trace[1511206302] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"273.723543ms","start":"2026-04-07T00:03:56.781888Z","end":"2026-04-07T00:03:57.055611Z","steps":["trace[1511206302] 'process raft request'  (duration: 273.242563ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:03:57.729671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.938803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-04-07T00:03:57.729762Z","caller":"traceutil/trace.go:171","msg":"trace[1455273756] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:620; }","duration":"383.071166ms","start":"2026-04-07T00:03:57.346669Z","end":"2026-04-07T00:03:57.72974Z","steps":["trace[1455273756] 'range keys from in-memory index tree'  (duration: 382.77352ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:03:57.729811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:03:57.346653Z","time spent":"383.149328ms","remote":"127.0.0.1:48856","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":"warn","ts":"2026-04-07T00:03:57.730162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.210216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-04-07T00:03:57.730288Z","caller":"traceutil/trace.go:171","msg":"trace[1770356336] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:620; }","duration":"514.729877ms","start":"2026-04-07T00:03:57.215535Z","end":"2026-04-07T00:03:57.730265Z","steps":["trace[1770356336] 'range keys from in-memory index tree'  (duration: 514.014833ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:03:57.730335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:03:57.215513Z","time spent":"514.808709ms","remote":"127.0.0.1:48856","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":"info","ts":"2026-04-07T00:03:57.732927Z","caller":"traceutil/trace.go:171","msg":"trace[368633621] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"275.235775ms","start":"2026-04-07T00:03:57.457672Z","end":"2026-04-07T00:03:57.732908Z","steps":["trace[368633621] 'process raft request'  (duration: 274.721305ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:05:27.559206Z","caller":"traceutil/trace.go:171","msg":"trace[993895420] transaction","detail":"{read_only:false; response_revision:1747; number_of_response:1; }","duration":"101.126257ms","start":"2026-04-07T00:05:27.458042Z","end":"2026-04-07T00:05:27.559168Z","steps":["trace[993895420] 'process raft request'  (duration: 100.78223ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:05:34.148174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.876264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-07T00:05:34.148245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.276985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-07T00:05:34.148269Z","caller":"traceutil/trace.go:171","msg":"trace[2055604551] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1857; }","duration":"232.023517ms","start":"2026-04-07T00:05:33.916228Z","end":"2026-04-07T00:05:34.148252Z","steps":["trace[2055604551] 'range keys from in-memory index tree'  (duration: 231.729421ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:05:34.148308Z","caller":"traceutil/trace.go:171","msg":"trace[188341774] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1857; }","duration":"145.395378ms","start":"2026-04-07T00:05:34.002899Z","end":"2026-04-07T00:05:34.148294Z","steps":["trace[188341774] 'count revisions from in-memory index tree'  (duration: 145.156553ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:05:34.148401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.018273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c989ec8e-9673-45a6-8d29-fbd89170b6c7\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-04-07T00:05:34.149503Z","caller":"traceutil/trace.go:171","msg":"trace[1546192572] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c989ec8e-9673-45a6-8d29-fbd89170b6c7; range_end:; response_count:1; response_revision:1857; }","duration":"300.224998ms","start":"2026-04-07T00:05:33.84925Z","end":"2026-04-07T00:05:34.149475Z","steps":["trace[1546192572] 'range keys from in-memory index tree'  (duration: 298.814589ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:05:34.149572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:05:33.849232Z","time spent":"300.31138ms","remote":"127.0.0.1:48792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3651,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c989ec8e-9673-45a6-8d29-fbd89170b6c7\" "}
{"level":"info","ts":"2026-04-07T00:05:34.291096Z","caller":"traceutil/trace.go:171","msg":"trace[387494022] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"133.934092ms","start":"2026-04-07T00:05:34.157133Z","end":"2026-04-07T00:05:34.291067Z","steps":["trace[387494022] 'process raft request'  (duration: 133.675706ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:05:34.527082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.088061ms","expected-duration":"100ms","prefix":"","request":"header:<ID:969009928032679893 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1807 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-07T00:05:34.527203Z","caller":"traceutil/trace.go:171","msg":"trace[1516449377] linearizableReadLoop","detail":"{readStateIndex:1935; appliedIndex:1934; }","duration":"169.384071ms","start":"2026-04-07T00:05:34.357798Z","end":"2026-04-07T00:05:34.527182Z","steps":["trace[1516449377] 'read index received'  (duration: 6.044926ms)","trace[1516449377] 'applied index is now lower than readState.Index'  (duration: 163.337805ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-07T00:05:34.527372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.468693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-07T00:05:34.527426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.618696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c989ec8e-9673-45a6-8d29-fbd89170b6c7\" ","response":"range_response_count:1 size:3744"}
{"level":"info","ts":"2026-04-07T00:05:34.527442Z","caller":"traceutil/trace.go:171","msg":"trace[1213353164] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1861; }","duration":"135.602166ms","start":"2026-04-07T00:05:34.391824Z","end":"2026-04-07T00:05:34.527426Z","steps":["trace[1213353164] 'agreement among raft nodes before linearized reading'  (duration: 135.490164ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:05:34.527488Z","caller":"traceutil/trace.go:171","msg":"trace[848593580] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c989ec8e-9673-45a6-8d29-fbd89170b6c7; range_end:; response_count:1; response_revision:1861; }","duration":"169.692857ms","start":"2026-04-07T00:05:34.357764Z","end":"2026-04-07T00:05:34.527457Z","steps":["trace[848593580] 'agreement among raft nodes before linearized reading'  (duration: 169.526363ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:05:34.527256Z","caller":"traceutil/trace.go:171","msg":"trace[2019266889] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"226.636487ms","start":"2026-04-07T00:05:34.300576Z","end":"2026-04-07T00:05:34.527213Z","steps":["trace[2019266889] 'process raft request'  (duration: 63.320522ms)","trace[2019266889] 'compare'  (duration: 162.944697ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:05:34.680364Z","caller":"traceutil/trace.go:171","msg":"trace[657879048] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"105.738573ms","start":"2026-04-07T00:05:34.574598Z","end":"2026-04-07T00:05:34.680337Z","steps":["trace[657879048] 'process raft request'  (duration: 96.304389ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:05:48.520938Z","caller":"traceutil/trace.go:171","msg":"trace[441549372] linearizableReadLoop","detail":"{readStateIndex:2054; appliedIndex:2053; }","duration":"151.531946ms","start":"2026-04-07T00:05:48.369382Z","end":"2026-04-07T00:05:48.520914Z","steps":["trace[441549372] 'read index received'  (duration: 151.26024ms)","trace[441549372] 'applied index is now lower than readState.Index'  (duration: 270.656µs)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:05:48.52103Z","caller":"traceutil/trace.go:171","msg":"trace[604583216] transaction","detail":"{read_only:false; response_revision:1977; number_of_response:1; }","duration":"177.789516ms","start":"2026-04-07T00:05:48.3432Z","end":"2026-04-07T00:05:48.52099Z","steps":["trace[604583216] 'process raft request'  (duration: 177.542411ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:05:48.521163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.76179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-04-07T00:05:48.521199Z","caller":"traceutil/trace.go:171","msg":"trace[1962807400] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1977; }","duration":"151.814681ms","start":"2026-04-07T00:05:48.369374Z","end":"2026-04-07T00:05:48.521189Z","steps":["trace[1962807400] 'agreement among raft nodes before linearized reading'  (duration: 151.672878ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:05:48.52123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.092695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-04-07T00:05:48.521267Z","caller":"traceutil/trace.go:171","msg":"trace[1441023866] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1977; }","duration":"129.161355ms","start":"2026-04-07T00:05:48.392095Z","end":"2026-04-07T00:05:48.521256Z","steps":["trace[1441023866] 'agreement among raft nodes before linearized reading'  (duration: 129.044443ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:06:06.730317Z","caller":"traceutil/trace.go:171","msg":"trace[1011395490] linearizableReadLoop","detail":"{readStateIndex:2172; appliedIndex:2171; }","duration":"135.709183ms","start":"2026-04-07T00:06:06.594582Z","end":"2026-04-07T00:06:06.730291Z","steps":["trace[1011395490] 'read index received'  (duration: 135.598841ms)","trace[1011395490] 'applied index is now lower than readState.Index'  (duration: 108.722µs)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:06:06.730358Z","caller":"traceutil/trace.go:171","msg":"trace[1618674032] transaction","detail":"{read_only:false; response_revision:2091; number_of_response:1; }","duration":"149.964376ms","start":"2026-04-07T00:06:06.580358Z","end":"2026-04-07T00:06:06.730322Z","steps":["trace[1618674032] 'process raft request'  (duration: 149.782902ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:06:06.730554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.948938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-04-07T00:06:06.730597Z","caller":"traceutil/trace.go:171","msg":"trace[988489373] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2091; }","duration":"136.05871ms","start":"2026-04-07T00:06:06.594527Z","end":"2026-04-07T00:06:06.730586Z","steps":["trace[988489373] 'agreement among raft nodes before linearized reading'  (duration: 135.888057ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:06:06.743538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.713301ms","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-07T00:06:06.743599Z","caller":"traceutil/trace.go:171","msg":"trace[746382831] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:2092; }","duration":"130.838423ms","start":"2026-04-07T00:06:06.612747Z","end":"2026-04-07T00:06:06.743585Z","steps":["trace[746382831] 'agreement among raft nodes before linearized reading'  (duration: 130.69611ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:06:06.743859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.543623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-07T00:06:06.743947Z","caller":"traceutil/trace.go:171","msg":"trace[1644444741] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:2092; }","duration":"123.767197ms","start":"2026-04-07T00:06:06.620155Z","end":"2026-04-07T00:06:06.743922Z","steps":["trace[1644444741] 'agreement among raft nodes before linearized reading'  (duration: 123.470841ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:06:07.095615Z","caller":"traceutil/trace.go:171","msg":"trace[910160849] transaction","detail":"{read_only:false; response_revision:2095; number_of_response:1; }","duration":"156.92245ms","start":"2026-04-07T00:06:06.938662Z","end":"2026-04-07T00:06:07.095585Z","steps":["trace[910160849] 'process raft request'  (duration: 104.409199ms)","trace[910160849] 'compare'  (duration: 52.270316ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:06:07.769304Z","caller":"traceutil/trace.go:171","msg":"trace[162406450] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"170.003938ms","start":"2026-04-07T00:06:07.599272Z","end":"2026-04-07T00:06:07.769275Z","steps":["trace[162406450] 'process raft request'  (duration: 169.732393ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:06:08.070583Z","caller":"traceutil/trace.go:171","msg":"trace[1992891842] linearizableReadLoop","detail":"{readStateIndex:2179; appliedIndex:2177; }","duration":"296.37459ms","start":"2026-04-07T00:06:07.774184Z","end":"2026-04-07T00:06:08.070559Z","steps":["trace[1992891842] 'read index received'  (duration: 76.989674ms)","trace[1992891842] 'applied index is now lower than readState.Index'  (duration: 219.383986ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:06:08.070705Z","caller":"traceutil/trace.go:171","msg":"trace[269358767] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"296.85762ms","start":"2026-04-07T00:06:07.773835Z","end":"2026-04-07T00:06:08.070693Z","steps":["trace[269358767] 'process raft request'  (duration: 296.452272ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:06:08.070933Z","caller":"traceutil/trace.go:171","msg":"trace[1339849117] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"295.073193ms","start":"2026-04-07T00:06:07.775844Z","end":"2026-04-07T00:06:08.070917Z","steps":["trace[1339849117] 'process raft request'  (duration: 294.678385ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:06:08.071067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.422828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-07T00:06:08.071057Z","caller":"traceutil/trace.go:171","msg":"trace[71734324] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"296.759569ms","start":"2026-04-07T00:06:07.774255Z","end":"2026-04-07T00:06:08.071014Z","steps":["trace[71734324] 'process raft request'  (duration: 296.191817ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:06:08.071114Z","caller":"traceutil/trace.go:171","msg":"trace[907112142] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2101; }","duration":"153.5166ms","start":"2026-04-07T00:06:07.917582Z","end":"2026-04-07T00:06:08.071098Z","steps":["trace[907112142] 'agreement among raft nodes before linearized reading'  (duration: 153.438369ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:06:08.07123Z","caller":"traceutil/trace.go:171","msg":"trace[49131376] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"295.594845ms","start":"2026-04-07T00:06:07.775618Z","end":"2026-04-07T00:06:08.071213Z","steps":["trace[49131376] 'process raft request'  (duration: 294.8675ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:06:08.071293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.082645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12386"}
{"level":"info","ts":"2026-04-07T00:06:08.071371Z","caller":"traceutil/trace.go:171","msg":"trace[1618550254] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2101; }","duration":"297.196668ms","start":"2026-04-07T00:06:07.774158Z","end":"2026-04-07T00:06:08.071354Z","steps":["trace[1618550254] 'agreement among raft nodes before linearized reading'  (duration: 296.975593ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:06:58.961505Z","caller":"traceutil/trace.go:171","msg":"trace[964097789] transaction","detail":"{read_only:false; response_revision:2387; number_of_response:1; }","duration":"148.30185ms","start":"2026-04-07T00:06:58.813174Z","end":"2026-04-07T00:06:58.961476Z","steps":["trace[964097789] 'process raft request'  (duration: 148.053064ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:07:20.122135Z","caller":"traceutil/trace.go:171","msg":"trace[1003247194] transaction","detail":"{read_only:false; response_revision:2595; number_of_response:1; }","duration":"120.528022ms","start":"2026-04-07T00:07:20.001588Z","end":"2026-04-07T00:07:20.122116Z","steps":["trace[1003247194] 'process raft request'  (duration: 120.430579ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:07:20.122179Z","caller":"traceutil/trace.go:171","msg":"trace[2083922967] linearizableReadLoop","detail":"{readStateIndex:2692; appliedIndex:2691; }","duration":"205.571747ms","start":"2026-04-07T00:07:19.916551Z","end":"2026-04-07T00:07:20.122123Z","steps":["trace[2083922967] 'read index received'  (duration: 204.347838ms)","trace[2083922967] 'applied index is now lower than readState.Index'  (duration: 1.211289ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-07T00:07:20.123089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.511518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-07T00:07:20.123222Z","caller":"traceutil/trace.go:171","msg":"trace[120364689] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2595; }","duration":"206.692902ms","start":"2026-04-07T00:07:19.916496Z","end":"2026-04-07T00:07:20.123189Z","steps":["trace[120364689] 'agreement among raft nodes before linearized reading'  (duration: 205.895204ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:07:44.334797Z","caller":"traceutil/trace.go:171","msg":"trace[1123667395] transaction","detail":"{read_only:false; response_revision:2722; number_of_response:1; }","duration":"124.189182ms","start":"2026-04-07T00:07:44.210574Z","end":"2026-04-07T00:07:44.334764Z","steps":["trace[1123667395] 'process raft request'  (duration: 124.046489ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:11:32.798727Z","caller":"traceutil/trace.go:171","msg":"trace[1157446850] transaction","detail":"{read_only:false; response_revision:4582; number_of_response:1; }","duration":"203.63881ms","start":"2026-04-07T00:11:32.595049Z","end":"2026-04-07T00:11:32.798688Z","steps":["trace[1157446850] 'process raft request'  (duration: 159.815127ms)","trace[1157446850] 'compare'  (duration: 43.606229ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:11:32.798691Z","caller":"traceutil/trace.go:171","msg":"trace[654758288] linearizableReadLoop","detail":"{readStateIndex:4758; appliedIndex:4756; }","duration":"149.385784ms","start":"2026-04-07T00:11:32.64928Z","end":"2026-04-07T00:11:32.798666Z","steps":["trace[654758288] 'read index received'  (duration: 12.037416ms)","trace[654758288] 'applied index is now lower than readState.Index'  (duration: 137.347038ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-07T00:11:32.79948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.185211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2193165"}
{"level":"info","ts":"2026-04-07T00:11:32.799557Z","caller":"traceutil/trace.go:171","msg":"trace[1257184308] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4582; }","duration":"150.271823ms","start":"2026-04-07T00:11:32.649269Z","end":"2026-04-07T00:11:32.799541Z","steps":["trace[1257184308] 'agreement among raft nodes before linearized reading'  (duration: 149.454215ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:11:32.821313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.606091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-eda7e009-54a5-4990-99cf-4e4465cf312b\" ","response":"range_response_count:1 size:3774"}
{"level":"info","ts":"2026-04-07T00:11:32.82137Z","caller":"traceutil/trace.go:171","msg":"trace[740997690] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-eda7e009-54a5-4990-99cf-4e4465cf312b; range_end:; response_count:1; response_revision:4583; }","duration":"120.703863ms","start":"2026-04-07T00:11:32.70065Z","end":"2026-04-07T00:11:32.821354Z","steps":["trace[740997690] 'agreement among raft nodes before linearized reading'  (duration: 120.54852ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:11:32.821478Z","caller":"traceutil/trace.go:171","msg":"trace[735090238] transaction","detail":"{read_only:false; response_revision:4583; number_of_response:1; }","duration":"160.074672ms","start":"2026-04-07T00:11:32.661381Z","end":"2026-04-07T00:11:32.821456Z","steps":["trace[735090238] 'process raft request'  (duration: 159.733215ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:11:38.654776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.565154ms","expected-duration":"100ms","prefix":"","request":"header:<ID:969009928032686881 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0.18a3eaab0d3e7c03\" mod_revision:0 > success:<request_put:<key:\"/registry/events/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0.18a3eaab0d3e7c03\" value_size:825 lease:969009928032686753 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-04-07T00:11:38.6549Z","caller":"traceutil/trace.go:171","msg":"trace[1471159850] transaction","detail":"{read_only:false; response_revision:4717; number_of_response:1; }","duration":"154.824567ms","start":"2026-04-07T00:11:38.500062Z","end":"2026-04-07T00:11:38.654886Z","steps":["trace[1471159850] 'process raft request'  (duration: 30.069219ms)","trace[1471159850] 'compare'  (duration: 124.444542ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:11:38.914908Z","caller":"traceutil/trace.go:171","msg":"trace[498355260] transaction","detail":"{read_only:false; response_revision:4718; number_of_response:1; }","duration":"256.644227ms","start":"2026-04-07T00:11:38.658225Z","end":"2026-04-07T00:11:38.914869Z","steps":["trace[498355260] 'process raft request'  (duration: 235.378124ms)","trace[498355260] 'compare'  (duration: 21.016918ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:11:38.941236Z","caller":"traceutil/trace.go:171","msg":"trace[305793556] transaction","detail":"{read_only:false; response_revision:4719; number_of_response:1; }","duration":"280.71871ms","start":"2026-04-07T00:11:38.660492Z","end":"2026-04-07T00:11:38.941211Z","steps":["trace[305793556] 'process raft request'  (duration: 280.570787ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:11:50.710932Z","caller":"traceutil/trace.go:171","msg":"trace[407359592] linearizableReadLoop","detail":"{readStateIndex:5073; appliedIndex:5072; }","duration":"146.399375ms","start":"2026-04-07T00:11:50.564506Z","end":"2026-04-07T00:11:50.710905Z","steps":["trace[407359592] 'read index received'  (duration: 140.475669ms)","trace[407359592] 'applied index is now lower than readState.Index'  (duration: 5.922716ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:11:50.710971Z","caller":"traceutil/trace.go:171","msg":"trace[890511427] transaction","detail":"{read_only:false; response_revision:4887; number_of_response:1; }","duration":"207.22839ms","start":"2026-04-07T00:11:50.50371Z","end":"2026-04-07T00:11:50.710938Z","steps":["trace[890511427] 'process raft request'  (duration: 201.258193ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:11:50.711167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.61041ms","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-07T00:11:50.711293Z","caller":"traceutil/trace.go:171","msg":"trace[2062552527] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4887; }","duration":"146.814634ms","start":"2026-04-07T00:11:50.564465Z","end":"2026-04-07T00:11:50.71128Z","steps":["trace[2062552527] 'agreement among raft nodes before linearized reading'  (duration: 146.513487ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:12:28.386992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.312662ms","expected-duration":"100ms","prefix":"","request":"header:<ID:969009928032688206 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5216 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:476 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-07T00:12:28.387084Z","caller":"traceutil/trace.go:171","msg":"trace[9370966] linearizableReadLoop","detail":"{readStateIndex:5423; appliedIndex:5422; }","duration":"144.142489ms","start":"2026-04-07T00:12:28.242927Z","end":"2026-04-07T00:12:28.38707Z","steps":["trace[9370966] 'read index received'  (duration: 16.604102ms)","trace[9370966] 'applied index is now lower than readState.Index'  (duration: 127.537517ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:12:28.387147Z","caller":"traceutil/trace.go:171","msg":"trace[1564428942] transaction","detail":"{read_only:false; response_revision:5229; number_of_response:1; }","duration":"149.656196ms","start":"2026-04-07T00:12:28.237463Z","end":"2026-04-07T00:12:28.387119Z","steps":["trace[1564428942] 'process raft request'  (duration: 22.128049ms)","trace[1564428942] 'compare'  (duration: 127.18297ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-07T00:12:28.387236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.307572ms","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-07T00:12:28.387256Z","caller":"traceutil/trace.go:171","msg":"trace[79499303] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5229; }","duration":"144.365064ms","start":"2026-04-07T00:12:28.242885Z","end":"2026-04-07T00:12:28.38725Z","steps":["trace[79499303] 'agreement among raft nodes before linearized reading'  (duration: 144.256091ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:12:28.387427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.365778ms","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-07T00:12:28.387452Z","caller":"traceutil/trace.go:171","msg":"trace[1690507989] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5229; }","duration":"140.43773ms","start":"2026-04-07T00:12:28.247006Z","end":"2026-04-07T00:12:28.387444Z","steps":["trace[1690507989] 'agreement among raft nodes before linearized reading'  (duration: 140.304097ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:13:20.656401Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2913}
{"level":"info","ts":"2026-04-07T00:13:20.730193Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2913,"took":"72.456502ms","hash":3544970366,"current-db-size-bytes":52756480,"current-db-size":"53 MB","current-db-size-in-use-bytes":29249536,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-04-07T00:13:20.730272Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3544970366,"revision":2913,"compact-revision":-1}
{"level":"info","ts":"2026-04-07T00:15:36.29681Z","caller":"traceutil/trace.go:171","msg":"trace[1447210052] linearizableReadLoop","detail":"{readStateIndex:6800; appliedIndex:6800; }","duration":"500.479666ms","start":"2026-04-07T00:15:35.796298Z","end":"2026-04-07T00:15:36.296778Z","steps":["trace[1447210052] 'read index received'  (duration: 500.467126ms)","trace[1447210052] 'applied index is now lower than readState.Index'  (duration: 9.68µs)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:15:36.29703Z","caller":"traceutil/trace.go:171","msg":"trace[1629518632] transaction","detail":"{read_only:false; response_revision:6558; number_of_response:1; }","duration":"501.039101ms","start":"2026-04-07T00:15:35.795702Z","end":"2026-04-07T00:15:36.296741Z","steps":["trace[1629518632] 'process raft request'  (duration: 500.873057ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:15:36.297179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.868058ms","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-07T00:15:36.29723Z","caller":"traceutil/trace.go:171","msg":"trace[595808306] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6558; }","duration":"500.95565ms","start":"2026-04-07T00:15:35.796259Z","end":"2026-04-07T00:15:36.297215Z","steps":["trace[595808306] 'agreement among raft nodes before linearized reading'  (duration: 500.724673ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:15:36.29727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:15:35.796248Z","time spent":"501.013402ms","remote":"127.0.0.1:48856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-07T00:15:36.298169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:15:35.795683Z","time spent":"501.438172ms","remote":"127.0.0.1:48856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:6523 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-04-07T00:15:36.299139Z","caller":"traceutil/trace.go:171","msg":"trace[904250920] transaction","detail":"{read_only:false; response_revision:6559; number_of_response:1; }","duration":"137.584758ms","start":"2026-04-07T00:15:36.161529Z","end":"2026-04-07T00:15:36.299113Z","steps":["trace[904250920] 'process raft request'  (duration: 136.211132ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:15:36.299443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.709005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-07T00:15:36.299481Z","caller":"traceutil/trace.go:171","msg":"trace[539050891] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6560; }","duration":"276.802177ms","start":"2026-04-07T00:15:36.02267Z","end":"2026-04-07T00:15:36.299472Z","steps":["trace[539050891] 'agreement among raft nodes before linearized reading'  (duration: 276.730165ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:15:36.300409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.694867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-07T00:15:36.300545Z","caller":"traceutil/trace.go:171","msg":"trace[420105362] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:6560; }","duration":"396.880922ms","start":"2026-04-07T00:15:35.903652Z","end":"2026-04-07T00:15:36.300533Z","steps":["trace[420105362] 'agreement among raft nodes before linearized reading'  (duration: 394.481928ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:15:36.300691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:15:35.903628Z","time spent":"397.051627ms","remote":"127.0.0.1:42266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "}
{"level":"info","ts":"2026-04-07T00:15:40.444563Z","caller":"traceutil/trace.go:171","msg":"trace[1965750727] transaction","detail":"{read_only:false; response_revision:6596; number_of_response:1; }","duration":"111.775023ms","start":"2026-04-07T00:15:40.332768Z","end":"2026-04-07T00:15:40.444543Z","steps":["trace[1965750727] 'process raft request'  (duration: 96.724834ms)","trace[1965750727] 'compare'  (duration: 14.869084ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:18:20.662759Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5631}
{"level":"info","ts":"2026-04-07T00:18:20.734231Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5631,"took":"70.311168ms","hash":4170030147,"current-db-size-bytes":52756480,"current-db-size":"53 MB","current-db-size-in-use-bytes":18182144,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-04-07T00:18:20.734283Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4170030147,"revision":5631,"compact-revision":2913}