{"level":"warn","ts":"2026-04-11T17:41:42.844742Z","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-11T17:41:42.844841Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.243: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.243:2380","--initial-cluster=instance=https://199.19.213.243:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.243:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.243: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-11T17:41:42.844914Z","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-11T17:41:42.844922Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.243:2380"]} {"level":"info","ts":"2026-04-11T17:41:42.84494Z","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-11T17:41:42.845556Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.243:2379"]} {"level":"info","ts":"2026-04-11T17:41:42.845641Z","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.243:2380"],"listen-peer-urls":["https://199.19.213.243:2380"],"advertise-client-urls":["https://199.19.213.243:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.243:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.243: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-11T17:41:42.850219Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.275128ms"} {"level":"info","ts":"2026-04-11T17:41:42.856257Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"864e14457b828f9c","cluster-id":"6c0ae60a355554b9"} {"level":"info","ts":"2026-04-11T17:41:42.856354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c switched to configuration voters=()"} {"level":"info","ts":"2026-04-11T17:41:42.856382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c became follower at term 0"} {"level":"info","ts":"2026-04-11T17:41:42.856399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 864e14457b828f9c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-11T17:41:42.856411Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c became follower at term 1"} {"level":"info","ts":"2026-04-11T17:41:42.856461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c switched to configuration voters=(9677694937923227548)"} {"level":"warn","ts":"2026-04-11T17:41:42.864294Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-11T17:41:42.869263Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-11T17:41:42.870031Z","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-11T17:41:42.871961Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"864e14457b828f9c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-11T17:41:42.872706Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"864e14457b828f9c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-11T17:41:42.876301Z","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-11T17:41:42.876359Z","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-11T17:41:42.876372Z","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-11T17:41:42.880398Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c switched to configuration voters=(9677694937923227548)"} {"level":"info","ts":"2026-04-11T17:41:42.880529Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6c0ae60a355554b9","local-member-id":"864e14457b828f9c","added-peer-id":"864e14457b828f9c","added-peer-peer-urls":["https://199.19.213.243:2380"]} {"level":"info","ts":"2026-04-11T17:41:42.880687Z","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-11T17:41:42.880882Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"864e14457b828f9c","initial-advertise-peer-urls":["https://199.19.213.243:2380"],"listen-peer-urls":["https://199.19.213.243:2380"],"advertise-client-urls":["https://199.19.213.243:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.243:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-11T17:41:42.880913Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-11T17:41:42.88103Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.243:2380"} {"level":"info","ts":"2026-04-11T17:41:42.881053Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.243:2380"} {"level":"info","ts":"2026-04-11T17:41:42.957426Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c is starting a new election at term 1"} {"level":"info","ts":"2026-04-11T17:41:42.957482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c became pre-candidate at term 1"} {"level":"info","ts":"2026-04-11T17:41:42.957505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c received MsgPreVoteResp from 864e14457b828f9c at term 1"} {"level":"info","ts":"2026-04-11T17:41:42.957518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c became candidate at term 2"} {"level":"info","ts":"2026-04-11T17:41:42.957528Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c received MsgVoteResp from 864e14457b828f9c at term 2"} {"level":"info","ts":"2026-04-11T17:41:42.957538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c became leader at term 2"} {"level":"info","ts":"2026-04-11T17:41:42.957546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 864e14457b828f9c elected leader 864e14457b828f9c at term 2"} {"level":"info","ts":"2026-04-11T17:41:42.958553Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-11T17:41:42.95923Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"864e14457b828f9c","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.243:2379]}","request-path":"/0/members/864e14457b828f9c/attributes","cluster-id":"6c0ae60a355554b9","publish-timeout":"7s"} {"level":"info","ts":"2026-04-11T17:41:42.959341Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-11T17:41:42.959409Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-11T17:41:42.961086Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-11T17:41:42.961105Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-11T17:41:42.961334Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.243:2379"} {"level":"info","ts":"2026-04-11T17:41:42.961614Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6c0ae60a355554b9","local-member-id":"864e14457b828f9c","cluster-version":"3.5"} {"level":"info","ts":"2026-04-11T17:41:42.961759Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-11T17:41:42.961802Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-11T17:41:42.963059Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-11T17:42:01.845949Z","caller":"traceutil/trace.go:171","msg":"trace[1332934257] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"246.503704ms","start":"2026-04-11T17:42:01.599425Z","end":"2026-04-11T17:42:01.845929Z","steps":["trace[1332934257] 'process raft request' (duration: 230.070361ms)","trace[1332934257] 'compare' (duration: 16.309832ms)"],"step_count":2} {"level":"warn","ts":"2026-04-11T17:42:02.273058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.414374ms","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-11T17:42:02.273132Z","caller":"traceutil/trace.go:171","msg":"trace[101595470] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:450; }","duration":"235.554495ms","start":"2026-04-11T17:42:02.037564Z","end":"2026-04-11T17:42:02.273118Z","steps":["trace[101595470] 'range keys from in-memory index tree' (duration: 235.339383ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:42:18.995468Z","caller":"traceutil/trace.go:171","msg":"trace[147422264] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"210.538178ms","start":"2026-04-11T17:42:18.784891Z","end":"2026-04-11T17:42:18.995429Z","steps":["trace[147422264] 'process raft request' (duration: 141.189853ms)","trace[147422264] 'compare' (duration: 68.90968ms)"],"step_count":2} {"level":"info","ts":"2026-04-11T17:42:18.995238Z","caller":"traceutil/trace.go:171","msg":"trace[39868240] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"201.46587ms","start":"2026-04-11T17:42:18.793734Z","end":"2026-04-11T17:42:18.9952Z","steps":["trace[39868240] 'read index received' (duration: 132.259279ms)","trace[39868240] 'applied index is now lower than readState.Index' (duration: 69.204961ms)"],"step_count":2} {"level":"warn","ts":"2026-04-11T17:42:18.996078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.139752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-11T17:42:18.996215Z","caller":"traceutil/trace.go:171","msg":"trace[2024655522] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:619; }","duration":"202.513044ms","start":"2026-04-11T17:42:18.793666Z","end":"2026-04-11T17:42:18.996179Z","steps":["trace[2024655522] 'agreement among raft nodes before linearized reading' (duration: 201.917874ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:42:18.996593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.715816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-11T17:42:18.996715Z","caller":"traceutil/trace.go:171","msg":"trace[248592459] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:619; }","duration":"129.960584ms","start":"2026-04-11T17:42:18.86671Z","end":"2026-04-11T17:42:18.996671Z","steps":["trace[248592459] 'agreement among raft nodes before linearized reading' (duration: 129.354354ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:42:19.721476Z","caller":"traceutil/trace.go:171","msg":"trace[1479175115] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"297.701249ms","start":"2026-04-11T17:42:19.423748Z","end":"2026-04-11T17:42:19.72145Z","steps":["trace[1479175115] 'process raft request' (duration: 297.158482ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:42:34.754686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.592799ms","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-11T17:42:34.754794Z","caller":"traceutil/trace.go:171","msg":"trace[1190896130] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:775; }","duration":"281.743984ms","start":"2026-04-11T17:42:34.473032Z","end":"2026-04-11T17:42:34.754776Z","steps":["trace[1190896130] 'range keys from in-memory index tree' (duration: 281.402745ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:42:34.755056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.757848ms","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-11T17:42:34.755173Z","caller":"traceutil/trace.go:171","msg":"trace[1109704305] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:775; }","duration":"301.007755ms","start":"2026-04-11T17:42:34.454113Z","end":"2026-04-11T17:42:34.755121Z","steps":["trace[1109704305] 'range keys from in-memory index tree' (duration: 300.531622ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:42:34.755215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T17:42:34.454083Z","time spent":"301.120789ms","remote":"127.0.0.1:43780","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-11T17:43:03.725437Z","caller":"traceutil/trace.go:171","msg":"trace[360736064] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"223.816016ms","start":"2026-04-11T17:43:03.501593Z","end":"2026-04-11T17:43:03.725409Z","steps":["trace[360736064] 'process raft request' (duration: 223.664932ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:43:50.352786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.000573ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-11T17:43:50.352869Z","caller":"traceutil/trace.go:171","msg":"trace[325019805] linearizableReadLoop","detail":"{readStateIndex:1910; appliedIndex:1909; }","duration":"158.289685ms","start":"2026-04-11T17:43:50.194567Z","end":"2026-04-11T17:43:50.352857Z","steps":["trace[325019805] 'read index received' (duration: 20.467889ms)","trace[325019805] 'applied index is now lower than readState.Index' (duration: 137.820796ms)"],"step_count":2} {"level":"warn","ts":"2026-04-11T17:43:50.352916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.348127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-11T17:43:50.352933Z","caller":"traceutil/trace.go:171","msg":"trace[2042646657] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1837; }","duration":"158.408887ms","start":"2026-04-11T17:43:50.194518Z","end":"2026-04-11T17:43:50.352927Z","steps":["trace[2042646657] 'agreement among raft nodes before linearized reading' (duration: 158.368927ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:43:50.35292Z","caller":"traceutil/trace.go:171","msg":"trace[1188425838] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"167.008041ms","start":"2026-04-11T17:43:50.185875Z","end":"2026-04-11T17:43:50.352883Z","steps":["trace[1188425838] 'process raft request' (duration: 29.212485ms)","trace[1188425838] 'compare' (duration: 136.762069ms)"],"step_count":2} {"level":"info","ts":"2026-04-11T17:43:50.366998Z","caller":"traceutil/trace.go:171","msg":"trace[1659871156] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"125.327059ms","start":"2026-04-11T17:43:50.241654Z","end":"2026-04-11T17:43:50.366981Z","steps":["trace[1659871156] 'process raft request' (duration: 125.219597ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:43:50.848399Z","caller":"traceutil/trace.go:171","msg":"trace[1846292806] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"190.714054ms","start":"2026-04-11T17:43:50.657661Z","end":"2026-04-11T17:43:50.848375Z","steps":["trace[1846292806] 'process raft request' (duration: 190.516041ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:43:50.977549Z","caller":"traceutil/trace.go:171","msg":"trace[1891555349] linearizableReadLoop","detail":"{readStateIndex:1913; appliedIndex:1911; }","duration":"222.601393ms","start":"2026-04-11T17:43:50.754922Z","end":"2026-04-11T17:43:50.977523Z","steps":["trace[1891555349] 'read index received' (duration: 93.294388ms)","trace[1891555349] 'applied index is now lower than readState.Index' (duration: 129.306125ms)"],"step_count":2} {"level":"warn","ts":"2026-04-11T17:43:50.977736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.804247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-40834504-cb7d-479f-b6d1-ce923e686120\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-04-11T17:43:50.97777Z","caller":"traceutil/trace.go:171","msg":"trace[2131827910] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-40834504-cb7d-479f-b6d1-ce923e686120; range_end:; response_count:1; response_revision:1840; }","duration":"222.891327ms","start":"2026-04-11T17:43:50.754869Z","end":"2026-04-11T17:43:50.97776Z","steps":["trace[2131827910] 'agreement among raft nodes before linearized reading' (duration: 222.762135ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:43:50.977725Z","caller":"traceutil/trace.go:171","msg":"trace[999666322] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"294.058209ms","start":"2026-04-11T17:43:50.683488Z","end":"2026-04-11T17:43:50.977546Z","steps":["trace[999666322] 'process raft request' (duration: 241.540608ms)","trace[999666322] 'compare' (duration: 52.393079ms)"],"step_count":2} {"level":"info","ts":"2026-04-11T17:43:51.002283Z","caller":"traceutil/trace.go:171","msg":"trace[1099393704] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"117.300886ms","start":"2026-04-11T17:43:50.884949Z","end":"2026-04-11T17:43:51.00225Z","steps":["trace[1099393704] 'process raft request' (duration: 117.073982ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:44:04.101431Z","caller":"traceutil/trace.go:171","msg":"trace[1628440070] transaction","detail":"{read_only:false; response_revision:1956; number_of_response:1; }","duration":"172.71476ms","start":"2026-04-11T17:44:03.928692Z","end":"2026-04-11T17:44:04.101407Z","steps":["trace[1628440070] 'process raft request' (duration: 172.561947ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:44:24.277535Z","caller":"traceutil/trace.go:171","msg":"trace[1937021540] linearizableReadLoop","detail":"{readStateIndex:2159; appliedIndex:2158; }","duration":"101.625956ms","start":"2026-04-11T17:44:24.175879Z","end":"2026-04-11T17:44:24.277505Z","steps":["trace[1937021540] 'read index received' (duration: 100.753274ms)","trace[1937021540] 'applied index is now lower than readState.Index' (duration: 870.952µs)"],"step_count":2} {"level":"info","ts":"2026-04-11T17:44:24.277604Z","caller":"traceutil/trace.go:171","msg":"trace[1756336298] transaction","detail":"{read_only:false; response_revision:2079; number_of_response:1; }","duration":"106.446776ms","start":"2026-04-11T17:44:24.171114Z","end":"2026-04-11T17:44:24.277561Z","steps":["trace[1756336298] 'process raft request' (duration: 106.224143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:44:24.277769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.853249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18a55e6f109b0f40\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-04-11T17:44:24.277838Z","caller":"traceutil/trace.go:171","msg":"trace[1141930480] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18a55e6f109b0f40; range_end:; response_count:1; response_revision:2079; }","duration":"101.982321ms","start":"2026-04-11T17:44:24.175838Z","end":"2026-04-11T17:44:24.27782Z","steps":["trace[1141930480] 'agreement among raft nodes before linearized reading' (duration: 101.778238ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:44:24.389963Z","caller":"traceutil/trace.go:171","msg":"trace[147380862] transaction","detail":"{read_only:false; response_revision:2080; number_of_response:1; }","duration":"108.649348ms","start":"2026-04-11T17:44:24.281283Z","end":"2026-04-11T17:44:24.389933Z","steps":["trace[147380862] 'process raft request' (duration: 101.774088ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:44:24.898867Z","caller":"traceutil/trace.go:171","msg":"trace[522350529] transaction","detail":"{read_only:false; response_revision:2082; number_of_response:1; }","duration":"102.206555ms","start":"2026-04-11T17:44:24.796628Z","end":"2026-04-11T17:44:24.898834Z","steps":["trace[522350529] 'process raft request' (duration: 101.937541ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:44:25.104832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.317519ms","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-11T17:44:25.104936Z","caller":"traceutil/trace.go:171","msg":"trace[1925525006] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2082; }","duration":"183.498782ms","start":"2026-04-11T17:44:24.92141Z","end":"2026-04-11T17:44:25.104909Z","steps":["trace[1925525006] 'range keys from in-memory index tree' (duration: 183.105367ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:44:25.10513Z","caller":"traceutil/trace.go:171","msg":"trace[1639175118] transaction","detail":"{read_only:false; response_revision:2083; number_of_response:1; }","duration":"154.782014ms","start":"2026-04-11T17:44:24.95031Z","end":"2026-04-11T17:44:25.105092Z","steps":["trace[1639175118] 'process raft request' (duration: 117.26055ms)","trace[1639175118] 'compare' (duration: 37.22225ms)"],"step_count":2} {"level":"info","ts":"2026-04-11T17:44:25.549178Z","caller":"traceutil/trace.go:171","msg":"trace[2103001822] linearizableReadLoop","detail":"{readStateIndex:2166; appliedIndex:2165; }","duration":"211.499193ms","start":"2026-04-11T17:44:25.337643Z","end":"2026-04-11T17:44:25.549142Z","steps":["trace[2103001822] 'read index received' (duration: 131.8643ms)","trace[2103001822] 'applied index is now lower than readState.Index' (duration: 79.633523ms)"],"step_count":2} {"level":"info","ts":"2026-04-11T17:44:25.549506Z","caller":"traceutil/trace.go:171","msg":"trace[386338345] transaction","detail":"{read_only:false; response_revision:2086; number_of_response:1; }","duration":"218.861599ms","start":"2026-04-11T17:44:25.33058Z","end":"2026-04-11T17:44:25.549442Z","steps":["trace[386338345] 'process raft request' (duration: 138.932962ms)","trace[386338345] 'compare' (duration: 79.472041ms)"],"step_count":2} {"level":"warn","ts":"2026-04-11T17:44:25.549804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.119202ms","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-11T17:44:25.549864Z","caller":"traceutil/trace.go:171","msg":"trace[287745205] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2086; }","duration":"212.238674ms","start":"2026-04-11T17:44:25.337608Z","end":"2026-04-11T17:44:25.549847Z","steps":["trace[287745205] 'agreement among raft nodes before linearized reading' (duration: 211.987609ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:44:25.549883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.616722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-11T17:44:25.549895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.134384ms","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-11T17:44:25.549928Z","caller":"traceutil/trace.go:171","msg":"trace[742383997] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2086; }","duration":"208.682883ms","start":"2026-04-11T17:44:25.341232Z","end":"2026-04-11T17:44:25.549915Z","steps":["trace[742383997] 'agreement among raft nodes before linearized reading' (duration: 208.552491ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:44:25.549948Z","caller":"traceutil/trace.go:171","msg":"trace[962916490] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2086; }","duration":"152.216925ms","start":"2026-04-11T17:44:25.397712Z","end":"2026-04-11T17:44:25.549929Z","steps":["trace[962916490] 'agreement among raft nodes before linearized reading' (duration: 152.082343ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:45:55.684697Z","caller":"traceutil/trace.go:171","msg":"trace[2056794503] transaction","detail":"{read_only:false; response_revision:2680; number_of_response:1; }","duration":"108.743519ms","start":"2026-04-11T17:45:55.575931Z","end":"2026-04-11T17:45:55.684675Z","steps":["trace[2056794503] 'process raft request' (duration: 108.391985ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:47.47147Z","caller":"traceutil/trace.go:171","msg":"trace[371891500] linearizableReadLoop","detail":"{readStateIndex:4734; appliedIndex:4732; }","duration":"104.885045ms","start":"2026-04-11T17:49:47.366561Z","end":"2026-04-11T17:49:47.471446Z","steps":["trace[371891500] 'read index received' (duration: 11.60137ms)","trace[371891500] 'applied index is now lower than readState.Index' (duration: 93.282655ms)"],"step_count":2} {"level":"info","ts":"2026-04-11T17:49:47.471497Z","caller":"traceutil/trace.go:171","msg":"trace[901301248] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4561; }","duration":"117.30204ms","start":"2026-04-11T17:49:47.354166Z","end":"2026-04-11T17:49:47.471468Z","steps":["trace[901301248] 'process raft request' (duration: 117.176087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:49:47.471701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.115759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-kxsz6.18a55eb9e17d95a4\" ","response":"range_response_count:1 size:832"} {"level":"info","ts":"2026-04-11T17:49:47.471746Z","caller":"traceutil/trace.go:171","msg":"trace[1531860730] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-kxsz6.18a55eb9e17d95a4; range_end:; response_count:1; response_revision:4561; }","duration":"105.205611ms","start":"2026-04-11T17:49:47.366528Z","end":"2026-04-11T17:49:47.471733Z","steps":["trace[1531860730] 'agreement among raft nodes before linearized reading' (duration: 105.036338ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:49:47.473677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.591229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"} {"level":"info","ts":"2026-04-11T17:49:47.473776Z","caller":"traceutil/trace.go:171","msg":"trace[931245901] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4562; }","duration":"104.704891ms","start":"2026-04-11T17:49:47.369038Z","end":"2026-04-11T17:49:47.473743Z","steps":["trace[931245901] 'agreement among raft nodes before linearized reading' (duration: 104.402565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:49:54.084921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.830194ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-11T17:49:54.085174Z","caller":"traceutil/trace.go:171","msg":"trace[1247616917] transaction","detail":"{read_only:false; response_revision:4647; number_of_response:1; }","duration":"280.407237ms","start":"2026-04-11T17:49:53.804713Z","end":"2026-04-11T17:49:54.085121Z","steps":["trace[1247616917] 'process raft request' (duration: 139.287458ms)","trace[1247616917] 'compare' (duration: 140.545139ms)"],"step_count":2} {"level":"info","ts":"2026-04-11T17:49:54.085291Z","caller":"traceutil/trace.go:171","msg":"trace[1404805980] linearizableReadLoop","detail":"{readStateIndex:4822; appliedIndex:4821; }","duration":"218.84596ms","start":"2026-04-11T17:49:53.866424Z","end":"2026-04-11T17:49:54.08527Z","steps":["trace[1404805980] 'read index received' (duration: 77.555248ms)","trace[1404805980] 'applied index is now lower than readState.Index' (duration: 141.288522ms)"],"step_count":2} {"level":"warn","ts":"2026-04-11T17:49:54.085404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.972202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-11T17:49:54.08542Z","caller":"traceutil/trace.go:171","msg":"trace[635030599] transaction","detail":"{read_only:false; response_revision:4648; number_of_response:1; }","duration":"143.538674ms","start":"2026-04-11T17:49:53.941852Z","end":"2026-04-11T17:49:54.08539Z","steps":["trace[635030599] 'process raft request' (duration: 143.177307ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:54.085439Z","caller":"traceutil/trace.go:171","msg":"trace[1709012290] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4648; }","duration":"219.010063ms","start":"2026-04-11T17:49:53.866419Z","end":"2026-04-11T17:49:54.085429Z","steps":["trace[1709012290] 'agreement among raft nodes before linearized reading' (duration: 218.927631ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:54.24511Z","caller":"traceutil/trace.go:171","msg":"trace[252142854] linearizableReadLoop","detail":"{readStateIndex:4824; appliedIndex:4823; }","duration":"118.3799ms","start":"2026-04-11T17:49:54.126711Z","end":"2026-04-11T17:49:54.245091Z","steps":["trace[252142854] 'read index received' (duration: 118.336829ms)","trace[252142854] 'applied index is now lower than readState.Index' (duration: 41.461µs)"],"step_count":2} {"level":"info","ts":"2026-04-11T17:49:54.245197Z","caller":"traceutil/trace.go:171","msg":"trace[2124433363] transaction","detail":"{read_only:false; response_revision:4649; number_of_response:1; }","duration":"151.171136ms","start":"2026-04-11T17:49:54.094019Z","end":"2026-04-11T17:49:54.24519Z","steps":["trace[2124433363] 'process raft request' (duration: 150.958481ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:49:54.245331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.601156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-11T17:49:54.24543Z","caller":"traceutil/trace.go:171","msg":"trace[61426807] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:4649; }","duration":"118.759908ms","start":"2026-04-11T17:49:54.126653Z","end":"2026-04-11T17:49:54.245412Z","steps":["trace[61426807] 'agreement among raft nodes before linearized reading' (duration: 118.565354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:49:54.254634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.0877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-11T17:49:54.254696Z","caller":"traceutil/trace.go:171","msg":"trace[459312412] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:4650; }","duration":"106.168012ms","start":"2026-04-11T17:49:54.148513Z","end":"2026-04-11T17:49:54.254681Z","steps":["trace[459312412] 'agreement among raft nodes before linearized reading' (duration: 106.039559ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:54.418521Z","caller":"traceutil/trace.go:171","msg":"trace[83766390] transaction","detail":"{read_only:false; response_revision:4655; number_of_response:1; }","duration":"102.546623ms","start":"2026-04-11T17:49:54.315949Z","end":"2026-04-11T17:49:54.418496Z","steps":["trace[83766390] 'process raft request' (duration: 43.470275ms)","trace[83766390] 'compare' (duration: 58.62985ms)"],"step_count":2} {"level":"warn","ts":"2026-04-11T17:49:54.634386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.732336ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-11T17:49:54.634919Z","caller":"traceutil/trace.go:171","msg":"trace[441867311] linearizableReadLoop","detail":"{readStateIndex:4836; appliedIndex:4831; }","duration":"203.584419ms","start":"2026-04-11T17:49:54.431321Z","end":"2026-04-11T17:49:54.634905Z","steps":["trace[441867311] 'read index received' (duration: 99.19283ms)","trace[441867311] 'applied index is now lower than readState.Index' (duration: 104.390709ms)"],"step_count":2} {"level":"info","ts":"2026-04-11T17:49:54.634941Z","caller":"traceutil/trace.go:171","msg":"trace[1052436573] transaction","detail":"{read_only:false; response_revision:4660; number_of_response:1; }","duration":"208.993651ms","start":"2026-04-11T17:49:54.425911Z","end":"2026-04-11T17:49:54.634905Z","steps":["trace[1052436573] 'process raft request' (duration: 208.620684ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:49:54.635061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.701421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-04-11T17:49:54.635145Z","caller":"traceutil/trace.go:171","msg":"trace[626829705] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4662; }","duration":"203.818513ms","start":"2026-04-11T17:49:54.431304Z","end":"2026-04-11T17:49:54.635123Z","steps":["trace[626829705] 'agreement among raft nodes before linearized reading' (duration: 203.64606ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:54.635396Z","caller":"traceutil/trace.go:171","msg":"trace[1484714529] transaction","detail":"{read_only:false; response_revision:4659; number_of_response:1; }","duration":"210.02746ms","start":"2026-04-11T17:49:54.425348Z","end":"2026-04-11T17:49:54.635376Z","steps":["trace[1484714529] 'process raft request' (duration: 209.156073ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:54.635447Z","caller":"traceutil/trace.go:171","msg":"trace[1293689694] transaction","detail":"{read_only:false; response_revision:4658; number_of_response:1; }","duration":"210.212013ms","start":"2026-04-11T17:49:54.425225Z","end":"2026-04-11T17:49:54.635437Z","steps":["trace[1293689694] 'process raft request' (duration: 209.236544ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:54.634973Z","caller":"traceutil/trace.go:171","msg":"trace[748724059] transaction","detail":"{read_only:false; response_revision:4661; number_of_response:1; }","duration":"206.157427ms","start":"2026-04-11T17:49:54.428749Z","end":"2026-04-11T17:49:54.634907Z","steps":["trace[748724059] 'process raft request' (duration: 205.926043ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:54.635211Z","caller":"traceutil/trace.go:171","msg":"trace[2110555650] transaction","detail":"{read_only:false; response_revision:4657; number_of_response:1; }","duration":"210.04483ms","start":"2026-04-11T17:49:54.42508Z","end":"2026-04-11T17:49:54.635125Z","steps":["trace[2110555650] 'process raft request' (duration: 105.487238ms)","trace[2110555650] 'compare' (duration: 103.619904ms)"],"step_count":2} {"level":"info","ts":"2026-04-11T17:49:54.771738Z","caller":"traceutil/trace.go:171","msg":"trace[859698494] transaction","detail":"{read_only:false; response_revision:4665; number_of_response:1; }","duration":"128.675522ms","start":"2026-04-11T17:49:54.643031Z","end":"2026-04-11T17:49:54.771706Z","steps":["trace[859698494] 'process raft request' (duration: 95.812307ms)","trace[859698494] 'compare' (duration: 32.57682ms)"],"step_count":2} {"level":"info","ts":"2026-04-11T17:49:54.771849Z","caller":"traceutil/trace.go:171","msg":"trace[519550115] linearizableReadLoop","detail":"{readStateIndex:4842; appliedIndex:4837; }","duration":"126.859021ms","start":"2026-04-11T17:49:54.644965Z","end":"2026-04-11T17:49:54.771824Z","steps":["trace[519550115] 'read index received' (duration: 40.589372ms)","trace[519550115] 'applied index is now lower than readState.Index' (duration: 86.268749ms)"],"step_count":2} {"level":"info","ts":"2026-04-11T17:49:54.772058Z","caller":"traceutil/trace.go:171","msg":"trace[97509834] transaction","detail":"{read_only:false; response_revision:4669; number_of_response:1; }","duration":"120.013952ms","start":"2026-04-11T17:49:54.652027Z","end":"2026-04-11T17:49:54.77204Z","steps":["trace[97509834] 'process raft request' (duration: 119.737056ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:54.772123Z","caller":"traceutil/trace.go:171","msg":"trace[866597133] transaction","detail":"{read_only:false; response_revision:4666; number_of_response:1; }","duration":"128.511631ms","start":"2026-04-11T17:49:54.643599Z","end":"2026-04-11T17:49:54.77211Z","steps":["trace[866597133] 'process raft request' (duration: 127.99873ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:54.771945Z","caller":"traceutil/trace.go:171","msg":"trace[297170114] transaction","detail":"{read_only:false; response_revision:4667; number_of_response:1; }","duration":"127.160486ms","start":"2026-04-11T17:49:54.644705Z","end":"2026-04-11T17:49:54.771866Z","steps":["trace[297170114] 'process raft request' (duration: 126.953872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:49:54.7724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.876101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-04-11T17:49:54.772368Z","caller":"traceutil/trace.go:171","msg":"trace[180684725] transaction","detail":"{read_only:false; response_revision:4668; number_of_response:1; }","duration":"127.251267ms","start":"2026-04-11T17:49:54.645049Z","end":"2026-04-11T17:49:54.7723Z","steps":["trace[180684725] 'process raft request' (duration: 126.664916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:49:54.772504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.491012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-04-11T17:49:54.772604Z","caller":"traceutil/trace.go:171","msg":"trace[1891715215] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4669; }","duration":"126.972492ms","start":"2026-04-11T17:49:54.645481Z","end":"2026-04-11T17:49:54.772453Z","steps":["trace[1891715215] 'agreement among raft nodes before linearized reading' (duration: 126.704277ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:54.772671Z","caller":"traceutil/trace.go:171","msg":"trace[1334090366] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4669; }","duration":"127.696176ms","start":"2026-04-11T17:49:54.644947Z","end":"2026-04-11T17:49:54.772644Z","steps":["trace[1334090366] 'agreement among raft nodes before linearized reading' (duration: 127.050304ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:50:06.751466Z","caller":"traceutil/trace.go:171","msg":"trace[999917686] linearizableReadLoop","detail":"{readStateIndex:5064; appliedIndex:5063; }","duration":"112.621347ms","start":"2026-04-11T17:50:06.638819Z","end":"2026-04-11T17:50:06.75144Z","steps":["trace[999917686] 'read index received' (duration: 112.476484ms)","trace[999917686] 'applied index is now lower than readState.Index' (duration: 143.773µs)"],"step_count":2} {"level":"info","ts":"2026-04-11T17:50:06.751615Z","caller":"traceutil/trace.go:171","msg":"trace[668550097] transaction","detail":"{read_only:false; response_revision:4882; number_of_response:1; }","duration":"190.18248ms","start":"2026-04-11T17:50:06.561315Z","end":"2026-04-11T17:50:06.751498Z","steps":["trace[668550097] 'process raft request' (duration: 189.946005ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:50:06.75184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.992633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-04-11T17:50:06.751895Z","caller":"traceutil/trace.go:171","msg":"trace[422929920] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4882; }","duration":"113.104805ms","start":"2026-04-11T17:50:06.638773Z","end":"2026-04-11T17:50:06.751878Z","steps":["trace[422929920] 'agreement among raft nodes before linearized reading' (duration: 112.767429ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:51:43.290408Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2933} {"level":"info","ts":"2026-04-11T17:51:43.40364Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2933,"took":"111.692164ms","hash":2526290321,"current-db-size-bytes":53383168,"current-db-size":"53 MB","current-db-size-in-use-bytes":29343744,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-11T17:51:43.403753Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2526290321,"revision":2933,"compact-revision":-1} {"level":"info","ts":"2026-04-11T17:54:02.573171Z","caller":"traceutil/trace.go:171","msg":"trace[76155776] transaction","detail":"{read_only:false; response_revision:6612; number_of_response:1; }","duration":"143.477672ms","start":"2026-04-11T17:54:02.42967Z","end":"2026-04-11T17:54:02.573148Z","steps":["trace[76155776] 'process raft request' (duration: 143.34975ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:54:02.615262Z","caller":"traceutil/trace.go:171","msg":"trace[202121887] linearizableReadLoop","detail":"{readStateIndex:6857; appliedIndex:6853; }","duration":"134.968526ms","start":"2026-04-11T17:54:02.480273Z","end":"2026-04-11T17:54:02.615241Z","steps":["trace[202121887] 'read index received' (duration: 92.767779ms)","trace[202121887] 'applied index is now lower than readState.Index' (duration: 42.199777ms)"],"step_count":2} {"level":"info","ts":"2026-04-11T17:54:02.615387Z","caller":"traceutil/trace.go:171","msg":"trace[267834401] transaction","detail":"{read_only:false; response_revision:6615; number_of_response:1; }","duration":"137.90354ms","start":"2026-04-11T17:54:02.477471Z","end":"2026-04-11T17:54:02.615375Z","steps":["trace[267834401] 'process raft request' (duration: 137.736597ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:54:02.615413Z","caller":"traceutil/trace.go:171","msg":"trace[1790075822] transaction","detail":"{read_only:false; response_revision:6613; number_of_response:1; }","duration":"183.169232ms","start":"2026-04-11T17:54:02.432225Z","end":"2026-04-11T17:54:02.615394Z","steps":["trace[1790075822] 'process raft request' (duration: 175.410398ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:54:02.615442Z","caller":"traceutil/trace.go:171","msg":"trace[452762587] transaction","detail":"{read_only:false; response_revision:6614; number_of_response:1; }","duration":"138.205614ms","start":"2026-04-11T17:54:02.477099Z","end":"2026-04-11T17:54:02.615304Z","steps":["trace[452762587] 'process raft request' (duration: 138.074812ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:54:02.615643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.355161ms","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-11T17:54:02.615668Z","caller":"traceutil/trace.go:171","msg":"trace[1909574585] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6615; }","duration":"135.412343ms","start":"2026-04-11T17:54:02.480249Z","end":"2026-04-11T17:54:02.615662Z","steps":["trace[1909574585] 'agreement among raft nodes before linearized reading' (duration: 135.352582ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:56:43.296773Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5653} {"level":"info","ts":"2026-04-11T17:56:43.367757Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5653,"took":"69.68089ms","hash":4185128062,"current-db-size-bytes":53383168,"current-db-size":"53 MB","current-db-size-in-use-bytes":18231296,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-11T17:56:43.367807Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4185128062,"revision":5653,"compact-revision":2933}