{"level":"warn","ts":"2026-04-10T17:56:36.374555Z","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-10T17:56:36.374676Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.193: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.193:2380","--initial-cluster=instance=https://199.19.213.193:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.193:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.193: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-10T17:56:36.374817Z","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-10T17:56:36.374839Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.193:2380"]}
{"level":"info","ts":"2026-04-10T17:56:36.374868Z","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-10T17:56:36.376081Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.193:2379"]}
{"level":"info","ts":"2026-04-10T17:56:36.376183Z","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.193:2380"],"listen-peer-urls":["https://199.19.213.193:2380"],"advertise-client-urls":["https://199.19.213.193:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.193:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.193: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-10T17:56:36.381339Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.904744ms"}
{"level":"info","ts":"2026-04-10T17:56:36.393572Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fc4b8086375a405d","cluster-id":"7155ef20751e16de"}
{"level":"info","ts":"2026-04-10T17:56:36.393685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d switched to configuration voters=()"}
{"level":"info","ts":"2026-04-10T17:56:36.393721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d became follower at term 0"}
{"level":"info","ts":"2026-04-10T17:56:36.393741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fc4b8086375a405d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-10T17:56:36.393763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d became follower at term 1"}
{"level":"info","ts":"2026-04-10T17:56:36.393821Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d switched to configuration voters=(18179765634753773661)"}
{"level":"warn","ts":"2026-04-10T17:56:36.403892Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-10T17:56:36.408148Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-10T17:56:36.409883Z","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-10T17:56:36.412983Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fc4b8086375a405d","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-10T17:56:36.413483Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fc4b8086375a405d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-10T17:56:36.413421Z","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-10T17:56:36.413872Z","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-10T17:56:36.413899Z","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-10T17:56:36.414332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d switched to configuration voters=(18179765634753773661)"}
{"level":"info","ts":"2026-04-10T17:56:36.414474Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7155ef20751e16de","local-member-id":"fc4b8086375a405d","added-peer-id":"fc4b8086375a405d","added-peer-peer-urls":["https://199.19.213.193:2380"]}
{"level":"info","ts":"2026-04-10T17:56:36.417707Z","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-10T17:56:36.417839Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.193:2380"}
{"level":"info","ts":"2026-04-10T17:56:36.417875Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.193:2380"}
{"level":"info","ts":"2026-04-10T17:56:36.418043Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fc4b8086375a405d","initial-advertise-peer-urls":["https://199.19.213.193:2380"],"listen-peer-urls":["https://199.19.213.193:2380"],"advertise-client-urls":["https://199.19.213.193:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.193:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-10T17:56:36.418098Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-10T17:56:37.094063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d is starting a new election at term 1"}
{"level":"info","ts":"2026-04-10T17:56:37.094125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-10T17:56:37.094172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d received MsgPreVoteResp from fc4b8086375a405d at term 1"}
{"level":"info","ts":"2026-04-10T17:56:37.094203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d became candidate at term 2"}
{"level":"info","ts":"2026-04-10T17:56:37.094214Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d received MsgVoteResp from fc4b8086375a405d at term 2"}
{"level":"info","ts":"2026-04-10T17:56:37.094231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d became leader at term 2"}
{"level":"info","ts":"2026-04-10T17:56:37.094245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fc4b8086375a405d elected leader fc4b8086375a405d at term 2"}
{"level":"info","ts":"2026-04-10T17:56:37.097085Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-10T17:56:37.097686Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fc4b8086375a405d","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.193:2379]}","request-path":"/0/members/fc4b8086375a405d/attributes","cluster-id":"7155ef20751e16de","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-10T17:56:37.097911Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-10T17:56:37.098042Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7155ef20751e16de","local-member-id":"fc4b8086375a405d","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-10T17:56:37.09806Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-10T17:56:37.098168Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-10T17:56:37.098216Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-10T17:56:37.100316Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-10T17:56:37.101252Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.193:2379"}
{"level":"info","ts":"2026-04-10T17:56:37.103952Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-10T17:56:37.103972Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-10T17:56:38.68165Z","caller":"traceutil/trace.go:171","msg":"trace[500015116] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"143.515692ms","start":"2026-04-10T17:56:38.538095Z","end":"2026-04-10T17:56:38.681611Z","steps":["trace[500015116] 'process raft request'  (duration: 137.941311ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:56:38.682003Z","caller":"traceutil/trace.go:171","msg":"trace[1063722282] transaction","detail":"{read_only:false; number_of_response:0; response_revision:13; }","duration":"143.715377ms","start":"2026-04-10T17:56:38.538231Z","end":"2026-04-10T17:56:38.681946Z","steps":["trace[1063722282] 'process raft request'  (duration: 143.540484ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:56:38.68213Z","caller":"traceutil/trace.go:171","msg":"trace[2011360921] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"143.264083ms","start":"2026-04-10T17:56:38.538799Z","end":"2026-04-10T17:56:38.682063Z","steps":["trace[2011360921] 'process raft request'  (duration: 143.045986ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:56:38.682134Z","caller":"traceutil/trace.go:171","msg":"trace[575049082] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"142.694279ms","start":"2026-04-10T17:56:38.539404Z","end":"2026-04-10T17:56:38.682099Z","steps":["trace[575049082] 'process raft request'  (duration: 142.523376ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:56:38.682503Z","caller":"traceutil/trace.go:171","msg":"trace[1639830137] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"143.024164ms","start":"2026-04-10T17:56:38.539446Z","end":"2026-04-10T17:56:38.682471Z","steps":["trace[1639830137] 'process raft request'  (duration: 142.516766ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:56:38.682611Z","caller":"traceutil/trace.go:171","msg":"trace[1384608594] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"142.71172ms","start":"2026-04-10T17:56:38.539882Z","end":"2026-04-10T17:56:38.682594Z","steps":["trace[1384608594] 'process raft request'  (duration: 142.131987ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:56:38.682998Z","caller":"traceutil/trace.go:171","msg":"trace[1285474712] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"142.762375ms","start":"2026-04-10T17:56:38.540209Z","end":"2026-04-10T17:56:38.682971Z","steps":["trace[1285474712] 'process raft request'  (duration: 142.318201ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:56:38.683101Z","caller":"traceutil/trace.go:171","msg":"trace[210650310] linearizableReadLoop","detail":"{readStateIndex:22; appliedIndex:15; }","duration":"118.04101ms","start":"2026-04-10T17:56:38.565043Z","end":"2026-04-10T17:56:38.683084Z","steps":["trace[210650310] 'read index received'  (duration: 111.056724ms)","trace[210650310] 'applied index is now lower than readState.Index'  (duration: 6.982406ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-10T17:56:38.683325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.91684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"}
{"level":"info","ts":"2026-04-10T17:56:38.683407Z","caller":"traceutil/trace.go:171","msg":"trace[54479603] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:18; }","duration":"142.06026ms","start":"2026-04-10T17:56:38.541333Z","end":"2026-04-10T17:56:38.683393Z","steps":["trace[54479603] 'agreement among raft nodes before linearized reading'  (duration: 141.845084ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-10T17:56:38.683701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.879132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-w6wnm\" ","response":"range_response_count:1 size:861"}
{"level":"info","ts":"2026-04-10T17:56:38.683767Z","caller":"traceutil/trace.go:171","msg":"trace[671819128] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-w6wnm; range_end:; response_count:1; response_revision:20; }","duration":"115.004961ms","start":"2026-04-10T17:56:38.568744Z","end":"2026-04-10T17:56:38.683749Z","steps":["trace[671819128] 'agreement among raft nodes before linearized reading'  (duration: 114.833748ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:56:38.683952Z","caller":"traceutil/trace.go:171","msg":"trace[1072812103] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"106.667253ms","start":"2026-04-10T17:56:38.57727Z","end":"2026-04-10T17:56:38.683937Z","steps":["trace[1072812103] 'process raft request'  (duration: 106.230929ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-10T17:56:38.684114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.066577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"}
{"level":"info","ts":"2026-04-10T17:56:38.68415Z","caller":"traceutil/trace.go:171","msg":"trace[428065608] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:20; }","duration":"115.152763ms","start":"2026-04-10T17:56:38.568988Z","end":"2026-04-10T17:56:38.684141Z","steps":["trace[428065608] 'agreement among raft nodes before linearized reading'  (duration: 115.091999ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:56:38.687502Z","caller":"traceutil/trace.go:171","msg":"trace[982450764] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"116.43317ms","start":"2026-04-10T17:56:38.571042Z","end":"2026-04-10T17:56:38.687475Z","steps":["trace[982450764] 'process raft request'  (duration: 111.975773ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-10T17:56:42.741206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.931834ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4638036332296645467 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/daemonsets/kube-system/kube-proxy\" mod_revision:0 > success:<request_put:<key:\"/registry/daemonsets/kube-system/kube-proxy\" value_size:2600 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-04-10T17:56:42.741328Z","caller":"traceutil/trace.go:171","msg":"trace[791184302] linearizableReadLoop","detail":"{readStateIndex:263; appliedIndex:262; }","duration":"497.741417ms","start":"2026-04-10T17:56:42.24357Z","end":"2026-04-10T17:56:42.741311Z","steps":["trace[791184302] 'read index received'  (duration: 167.0003ms)","trace[791184302] 'applied index is now lower than readState.Index'  (duration: 330.739747ms)"],"step_count":2}
{"level":"info","ts":"2026-04-10T17:56:42.741369Z","caller":"traceutil/trace.go:171","msg":"trace[255702560] transaction","detail":"{read_only:false; response_revision:254; number_of_response:1; }","duration":"506.172992ms","start":"2026-04-10T17:56:42.235157Z","end":"2026-04-10T17:56:42.74133Z","steps":["trace[255702560] 'process raft request'  (duration: 175.473447ms)","trace[255702560] 'compare'  (duration: 329.821466ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-10T17:56:42.741493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.906131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-10T17:56:42.741673Z","caller":"traceutil/trace.go:171","msg":"trace[1120702052] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/attachdetach-controller; range_end:; response_count:0; response_revision:254; }","duration":"498.103796ms","start":"2026-04-10T17:56:42.24354Z","end":"2026-04-10T17:56:42.741644Z","steps":["trace[1120702052] 'agreement among raft nodes before linearized reading'  (duration: 497.831895ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-10T17:56:42.741801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T17:56:42.243527Z","time spent":"498.261588ms","remote":"127.0.0.1:51502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" "}
{"level":"warn","ts":"2026-04-10T17:56:42.741623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T17:56:42.235146Z","time spent":"506.325644ms","remote":"127.0.0.1:51752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2651,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/daemonsets/kube-system/kube-proxy\" mod_revision:0 > success:<request_put:<key:\"/registry/daemonsets/kube-system/kube-proxy\" value_size:2600 >> failure:<>"}
{"level":"info","ts":"2026-04-10T17:56:42.995998Z","caller":"traceutil/trace.go:171","msg":"trace[1160981233] transaction","detail":"{read_only:false; response_revision:255; number_of_response:1; }","duration":"250.973988ms","start":"2026-04-10T17:56:42.745Z","end":"2026-04-10T17:56:42.995974Z","steps":["trace[1160981233] 'process raft request'  (duration: 157.224152ms)","trace[1160981233] 'compare'  (duration: 93.460653ms)"],"step_count":2}
{"level":"info","ts":"2026-04-10T17:56:42.996042Z","caller":"traceutil/trace.go:171","msg":"trace[755832612] transaction","detail":"{read_only:false; response_revision:257; number_of_response:1; }","duration":"248.180601ms","start":"2026-04-10T17:56:42.747831Z","end":"2026-04-10T17:56:42.996012Z","steps":["trace[755832612] 'process raft request'  (duration: 248.124106ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:56:42.996038Z","caller":"traceutil/trace.go:171","msg":"trace[2057800513] transaction","detail":"{read_only:false; response_revision:256; number_of_response:1; }","duration":"248.622574ms","start":"2026-04-10T17:56:42.747376Z","end":"2026-04-10T17:56:42.995998Z","steps":["trace[2057800513] 'process raft request'  (duration: 248.511406ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-10T17:56:42.996116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.283454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-10T17:56:42.996002Z","caller":"traceutil/trace.go:171","msg":"trace[20510886] linearizableReadLoop","detail":"{readStateIndex:266; appliedIndex:263; }","duration":"158.162065ms","start":"2026-04-10T17:56:42.837816Z","end":"2026-04-10T17:56:42.995978Z","steps":["trace[20510886] 'read index received'  (duration: 64.42391ms)","trace[20510886] 'applied index is now lower than readState.Index'  (duration: 93.737245ms)"],"step_count":2}
{"level":"info","ts":"2026-04-10T17:56:42.996324Z","caller":"traceutil/trace.go:171","msg":"trace[808515909] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:257; }","duration":"158.36029ms","start":"2026-04-10T17:56:42.837781Z","end":"2026-04-10T17:56:42.996141Z","steps":["trace[808515909] 'agreement among raft nodes before linearized reading'  (duration: 158.264502ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-10T17:56:43.004684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.848693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-10T17:56:43.004746Z","caller":"traceutil/trace.go:171","msg":"trace[1963856214] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:258; }","duration":"156.93675ms","start":"2026-04-10T17:56:42.847794Z","end":"2026-04-10T17:56:43.004731Z","steps":["trace[1963856214] 'agreement among raft nodes before linearized reading'  (duration: 156.822181ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:57:07.384102Z","caller":"traceutil/trace.go:171","msg":"trace[1973348740] linearizableReadLoop","detail":"{readStateIndex:495; appliedIndex:489; }","duration":"112.269673ms","start":"2026-04-10T17:57:07.271813Z","end":"2026-04-10T17:57:07.384083Z","steps":["trace[1973348740] 'read index received'  (duration: 80.732015ms)","trace[1973348740] 'applied index is now lower than readState.Index'  (duration: 31.536968ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-10T17:57:07.384218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.782376ms","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-10T17:57:07.384244Z","caller":"traceutil/trace.go:171","msg":"trace[260353192] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:481; }","duration":"153.853141ms","start":"2026-04-10T17:57:07.230383Z","end":"2026-04-10T17:57:07.384236Z","steps":["trace[260353192] 'agreement among raft nodes before linearized reading'  (duration: 153.776375ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:57:07.384794Z","caller":"traceutil/trace.go:171","msg":"trace[1276579737] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"109.7876ms","start":"2026-04-10T17:57:07.274994Z","end":"2026-04-10T17:57:07.384782Z","steps":["trace[1276579737] 'process raft request'  (duration: 108.879511ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:57:07.384862Z","caller":"traceutil/trace.go:171","msg":"trace[1466973424] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"114.110514ms","start":"2026-04-10T17:57:07.270741Z","end":"2026-04-10T17:57:07.384852Z","steps":["trace[1466973424] 'process raft request'  (duration: 113.040171ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:57:07.385033Z","caller":"traceutil/trace.go:171","msg":"trace[1233960254] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"107.72152ms","start":"2026-04-10T17:57:07.277302Z","end":"2026-04-10T17:57:07.385023Z","steps":["trace[1233960254] 'process raft request'  (duration: 106.616505ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:57:07.385151Z","caller":"traceutil/trace.go:171","msg":"trace[1501367907] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"103.047666ms","start":"2026-04-10T17:57:07.282095Z","end":"2026-04-10T17:57:07.385142Z","steps":["trace[1501367907] 'process raft request'  (duration: 101.855633ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:57:07.385064Z","caller":"traceutil/trace.go:171","msg":"trace[2146045193] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"111.850498ms","start":"2026-04-10T17:57:07.273201Z","end":"2026-04-10T17:57:07.385052Z","steps":["trace[2146045193] 'process raft request'  (duration: 110.614581ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:57:07.384789Z","caller":"traceutil/trace.go:171","msg":"trace[928838395] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"114.487746ms","start":"2026-04-10T17:57:07.270274Z","end":"2026-04-10T17:57:07.384761Z","steps":["trace[928838395] 'process raft request'  (duration: 113.409953ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:57:13.482898Z","caller":"traceutil/trace.go:171","msg":"trace[200368391] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"156.086264ms","start":"2026-04-10T17:57:13.326788Z","end":"2026-04-10T17:57:13.482875Z","steps":["trace[200368391] 'process raft request'  (duration: 155.613863ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:57:13.503517Z","caller":"traceutil/trace.go:171","msg":"trace[613450755] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"162.653221ms","start":"2026-04-10T17:57:13.34082Z","end":"2026-04-10T17:57:13.503473Z","steps":["trace[613450755] 'process raft request'  (duration: 162.260286ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:57:13.730797Z","caller":"traceutil/trace.go:171","msg":"trace[669353732] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"189.182619ms","start":"2026-04-10T17:57:13.541589Z","end":"2026-04-10T17:57:13.730772Z","steps":["trace[669353732] 'process raft request'  (duration: 189.028266ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-10T17:57:14.280612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.117806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-10T17:57:14.280664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.437565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-clbrh\" ","response":"range_response_count:1 size:16965"}
{"level":"warn","ts":"2026-04-10T17:57:14.280711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.443036ms","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-10T17:57:14.280787Z","caller":"traceutil/trace.go:171","msg":"trace[155486949] range","detail":"{range_begin:/registry/pods/kube-system/cilium-clbrh; range_end:; response_count:1; response_revision:580; }","duration":"201.61568ms","start":"2026-04-10T17:57:14.07914Z","end":"2026-04-10T17:57:14.280755Z","steps":["trace[155486949] 'range keys from in-memory index tree'  (duration: 201.180072ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:57:14.28071Z","caller":"traceutil/trace.go:171","msg":"trace[874761021] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:580; }","duration":"440.314843ms","start":"2026-04-10T17:57:13.840357Z","end":"2026-04-10T17:57:14.280672Z","steps":["trace[874761021] 'range keys from in-memory index tree'  (duration: 439.970472ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-10T17:57:14.281099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T17:57:13.840333Z","time spent":"440.749931ms","remote":"127.0.0.1:51288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-10T17:57:14.280814Z","caller":"traceutil/trace.go:171","msg":"trace[1563919203] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:580; }","duration":"289.594871ms","start":"2026-04-10T17:57:13.991196Z","end":"2026-04-10T17:57:14.280791Z","steps":["trace[1563919203] 'range keys from in-memory index tree'  (duration: 289.273862ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:57:14.28263Z","caller":"traceutil/trace.go:171","msg":"trace[884358353] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"160.832481ms","start":"2026-04-10T17:57:14.121777Z","end":"2026-04-10T17:57:14.28261Z","steps":["trace[884358353] 'process raft request'  (duration: 159.966125ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:58:02.438521Z","caller":"traceutil/trace.go:171","msg":"trace[1208412839] transaction","detail":"{read_only:false; response_revision:1153; number_of_response:1; }","duration":"109.825893ms","start":"2026-04-10T17:58:02.328671Z","end":"2026-04-10T17:58:02.438497Z","steps":["trace[1208412839] 'process raft request'  (duration: 109.607306ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-10T17:58:55.406498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.538164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:553"}
{"level":"info","ts":"2026-04-10T17:58:55.406608Z","caller":"traceutil/trace.go:171","msg":"trace[476157485] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1845; }","duration":"226.69356ms","start":"2026-04-10T17:58:55.179888Z","end":"2026-04-10T17:58:55.406582Z","steps":["trace[476157485] 'range keys from in-memory index tree'  (duration: 226.336777ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-10T17:58:55.406809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.772144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-11efd6ab-5a8b-4841-80c8-b49f4b5e893f\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-04-10T17:58:55.406884Z","caller":"traceutil/trace.go:171","msg":"trace[810927233] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-11efd6ab-5a8b-4841-80c8-b49f4b5e893f; range_end:; response_count:1; response_revision:1845; }","duration":"247.895829ms","start":"2026-04-10T17:58:55.158968Z","end":"2026-04-10T17:58:55.406864Z","steps":["trace[810927233] 'range keys from in-memory index tree'  (duration: 247.568106ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:58:55.704756Z","caller":"traceutil/trace.go:171","msg":"trace[1813164868] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"135.81505ms","start":"2026-04-10T17:58:55.568906Z","end":"2026-04-10T17:58:55.704721Z","steps":["trace[1813164868] 'process raft request'  (duration: 135.113334ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:58:55.715287Z","caller":"traceutil/trace.go:171","msg":"trace[1918947456] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"144.866017ms","start":"2026-04-10T17:58:55.570391Z","end":"2026-04-10T17:58:55.715257Z","steps":["trace[1918947456] 'process raft request'  (duration: 144.451582ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:59:02.020552Z","caller":"traceutil/trace.go:171","msg":"trace[1115035591] transaction","detail":"{read_only:false; response_revision:1901; number_of_response:1; }","duration":"177.596676ms","start":"2026-04-10T17:59:01.842932Z","end":"2026-04-10T17:59:02.020529Z","steps":["trace[1115035591] 'process raft request'  (duration: 177.45083ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:59:46.863915Z","caller":"traceutil/trace.go:171","msg":"trace[1718990371] transaction","detail":"{read_only:false; response_revision:2171; number_of_response:1; }","duration":"180.919694ms","start":"2026-04-10T17:59:46.682928Z","end":"2026-04-10T17:59:46.863848Z","steps":["trace[1718990371] 'process raft request'  (duration: 175.685129ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-10T17:59:47.231137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.332209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-10T17:59:47.231263Z","caller":"traceutil/trace.go:171","msg":"trace[937913219] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:2172; }","duration":"172.515639ms","start":"2026-04-10T17:59:47.058723Z","end":"2026-04-10T17:59:47.231239Z","steps":["trace[937913219] 'count revisions from in-memory index tree'  (duration: 172.241463ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T17:59:47.284561Z","caller":"traceutil/trace.go:171","msg":"trace[203480569] linearizableReadLoop","detail":"{readStateIndex:2259; appliedIndex:2258; }","duration":"148.049777ms","start":"2026-04-10T17:59:47.136486Z","end":"2026-04-10T17:59:47.284536Z","steps":["trace[203480569] 'read index received'  (duration: 147.932371ms)","trace[203480569] 'applied index is now lower than readState.Index'  (duration: 116.376µs)"],"step_count":2}
{"level":"info","ts":"2026-04-10T17:59:47.284623Z","caller":"traceutil/trace.go:171","msg":"trace[188306013] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"208.687237ms","start":"2026-04-10T17:59:47.075914Z","end":"2026-04-10T17:59:47.284601Z","steps":["trace[188306013] 'process raft request'  (duration: 208.476335ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-10T17:59:47.284762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.25835ms","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-10T17:59:47.284821Z","caller":"traceutil/trace.go:171","msg":"trace[774079594] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2173; }","duration":"148.356295ms","start":"2026-04-10T17:59:47.136438Z","end":"2026-04-10T17:59:47.284795Z","steps":["trace[774079594] 'agreement among raft nodes before linearized reading'  (duration: 148.198356ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-10T18:01:06.504266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.175376ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4638036332296650745 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2695 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:462 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-10T18:01:06.504765Z","caller":"traceutil/trace.go:171","msg":"trace[1669279133] transaction","detail":"{read_only:false; response_revision:2707; number_of_response:1; }","duration":"350.249464ms","start":"2026-04-10T18:01:06.154491Z","end":"2026-04-10T18:01:06.504741Z","steps":["trace[1669279133] 'process raft request'  (duration: 136.349717ms)","trace[1669279133] 'compare'  (duration: 213.017475ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-10T18:01:06.504865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:01:06.154471Z","time spent":"350.34643ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":538,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2695 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:462 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-10T18:01:06.505149Z","caller":"traceutil/trace.go:171","msg":"trace[613092922] linearizableReadLoop","detail":"{readStateIndex:2812; appliedIndex:2811; }","duration":"269.836882ms","start":"2026-04-10T18:01:06.2353Z","end":"2026-04-10T18:01:06.505137Z","steps":["trace[613092922] 'read index received'  (duration: 55.553708ms)","trace[613092922] 'applied index is now lower than readState.Index'  (duration: 214.281834ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-10T18:01:06.505309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.011224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-04-10T18:01:06.505341Z","caller":"traceutil/trace.go:171","msg":"trace[849439175] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2707; }","duration":"270.09223ms","start":"2026-04-10T18:01:06.23524Z","end":"2026-04-10T18:01:06.505332Z","steps":["trace[849439175] 'agreement among raft nodes before linearized reading'  (duration: 269.943219ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T18:01:06.505531Z","caller":"traceutil/trace.go:171","msg":"trace[1433658875] transaction","detail":"{read_only:false; response_revision:2708; number_of_response:1; }","duration":"226.210974ms","start":"2026-04-10T18:01:06.279305Z","end":"2026-04-10T18:01:06.505516Z","steps":["trace[1433658875] 'process raft request'  (duration: 226.00624ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T18:03:35.472223Z","caller":"traceutil/trace.go:171","msg":"trace[1358137648] transaction","detail":"{read_only:false; response_revision:3579; number_of_response:1; }","duration":"162.850953ms","start":"2026-04-10T18:03:35.309351Z","end":"2026-04-10T18:03:35.472202Z","steps":["trace[1358137648] 'process raft request'  (duration: 162.540219ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T18:03:35.610243Z","caller":"traceutil/trace.go:171","msg":"trace[1111458141] transaction","detail":"{read_only:false; response_revision:3580; number_of_response:1; }","duration":"133.642058ms","start":"2026-04-10T18:03:35.476575Z","end":"2026-04-10T18:03:35.610218Z","steps":["trace[1111458141] 'process raft request'  (duration: 77.552751ms)","trace[1111458141] 'compare'  (duration: 55.990666ms)"],"step_count":2}
{"level":"info","ts":"2026-04-10T18:03:35.610238Z","caller":"traceutil/trace.go:171","msg":"trace[2002162914] linearizableReadLoop","detail":"{readStateIndex:3718; appliedIndex:3717; }","duration":"112.159223ms","start":"2026-04-10T18:03:35.498055Z","end":"2026-04-10T18:03:35.610214Z","steps":["trace[2002162914] 'read index received'  (duration: 56.043846ms)","trace[2002162914] 'applied index is now lower than readState.Index'  (duration: 56.114407ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-10T18:03:35.610356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.276514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-10T18:03:35.610758Z","caller":"traceutil/trace.go:171","msg":"trace[707243970] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:3580; }","duration":"112.717668ms","start":"2026-04-10T18:03:35.498025Z","end":"2026-04-10T18:03:35.610743Z","steps":["trace[707243970] 'agreement among raft nodes before linearized reading'  (duration: 112.275273ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T18:04:50.490917Z","caller":"traceutil/trace.go:171","msg":"trace[1287365791] transaction","detail":"{read_only:false; response_revision:4502; number_of_response:1; }","duration":"148.415504ms","start":"2026-04-10T18:04:50.342477Z","end":"2026-04-10T18:04:50.490893Z","steps":["trace[1287365791] 'process raft request'  (duration: 147.197893ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T18:04:59.853779Z","caller":"traceutil/trace.go:171","msg":"trace[1534068820] transaction","detail":"{read_only:false; response_revision:4697; number_of_response:1; }","duration":"189.385647ms","start":"2026-04-10T18:04:59.664373Z","end":"2026-04-10T18:04:59.853759Z","steps":["trace[1534068820] 'process raft request'  (duration: 188.876299ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-10T18:05:00.123631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.496634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"}
{"level":"info","ts":"2026-04-10T18:05:00.123744Z","caller":"traceutil/trace.go:171","msg":"trace[343838455] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4697; }","duration":"217.645749ms","start":"2026-04-10T18:04:59.906067Z","end":"2026-04-10T18:05:00.123712Z","steps":["trace[343838455] 'range keys from in-memory index tree'  (duration: 217.311339ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T18:05:00.131489Z","caller":"traceutil/trace.go:171","msg":"trace[1691820227] transaction","detail":"{read_only:false; response_revision:4698; number_of_response:1; }","duration":"214.138661ms","start":"2026-04-10T18:04:59.917317Z","end":"2026-04-10T18:05:00.131455Z","steps":["trace[1691820227] 'process raft request'  (duration: 214.005206ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T18:05:00.131526Z","caller":"traceutil/trace.go:171","msg":"trace[150667086] linearizableReadLoop","detail":"{readStateIndex:4878; appliedIndex:4878; }","duration":"135.756273ms","start":"2026-04-10T18:04:59.995755Z","end":"2026-04-10T18:05:00.131512Z","steps":["trace[150667086] 'read index received'  (duration: 135.744922ms)","trace[150667086] 'applied index is now lower than readState.Index'  (duration: 7.421µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-10T18:05:00.131889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.124995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-04-10T18:05:00.131938Z","caller":"traceutil/trace.go:171","msg":"trace[1395008580] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4698; }","duration":"136.184307ms","start":"2026-04-10T18:04:59.995739Z","end":"2026-04-10T18:05:00.131924Z","steps":["trace[1395008580] 'agreement among raft nodes before linearized reading'  (duration: 135.855036ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-10T18:05:00.575804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.012344ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4638036332296655713 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:4484 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-10T18:05:00.576089Z","caller":"traceutil/trace.go:171","msg":"trace[1162946405] transaction","detail":"{read_only:false; response_revision:4706; number_of_response:1; }","duration":"299.64539ms","start":"2026-04-10T18:05:00.276404Z","end":"2026-04-10T18:05:00.576049Z","steps":["trace[1162946405] 'process raft request'  (duration: 128.17348ms)","trace[1162946405] 'compare'  (duration: 170.540107ms)"],"step_count":2}
{"level":"info","ts":"2026-04-10T18:05:00.576257Z","caller":"traceutil/trace.go:171","msg":"trace[1730727377] transaction","detail":"{read_only:false; response_revision:4707; number_of_response:1; }","duration":"291.286698ms","start":"2026-04-10T18:05:00.284949Z","end":"2026-04-10T18:05:00.576236Z","steps":["trace[1730727377] 'process raft request'  (duration: 290.964087ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-10T18:05:00.576605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.890704ms","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-10T18:05:00.576014Z","caller":"traceutil/trace.go:171","msg":"trace[833732047] linearizableReadLoop","detail":"{readStateIndex:4887; appliedIndex:4885; }","duration":"280.73038ms","start":"2026-04-10T18:05:00.295265Z","end":"2026-04-10T18:05:00.575995Z","steps":["trace[833732047] 'read index received'  (duration: 109.622633ms)","trace[833732047] 'applied index is now lower than readState.Index'  (duration: 171.106837ms)"],"step_count":2}
{"level":"info","ts":"2026-04-10T18:05:00.576701Z","caller":"traceutil/trace.go:171","msg":"trace[1317203962] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4707; }","duration":"297.019719ms","start":"2026-04-10T18:05:00.27966Z","end":"2026-04-10T18:05:00.576679Z","steps":["trace[1317203962] 'agreement among raft nodes before linearized reading'  (duration: 296.7662ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T18:05:00.599098Z","caller":"traceutil/trace.go:171","msg":"trace[876579980] transaction","detail":"{read_only:false; response_revision:4708; number_of_response:1; }","duration":"301.955311ms","start":"2026-04-10T18:05:00.297122Z","end":"2026-04-10T18:05:00.599077Z","steps":["trace[876579980] 'process raft request'  (duration: 301.766964ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T18:05:00.599329Z","caller":"traceutil/trace.go:171","msg":"trace[1119562541] transaction","detail":"{read_only:false; response_revision:4709; number_of_response:1; }","duration":"300.056774ms","start":"2026-04-10T18:05:00.299251Z","end":"2026-04-10T18:05:00.599308Z","steps":["trace[1119562541] 'process raft request'  (duration: 299.749443ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-10T18:05:00.599344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.435291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a7105f5f-c62b-4d7c-a435-a1c68e1eefe6\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-04-10T18:05:00.599436Z","caller":"traceutil/trace.go:171","msg":"trace[518707569] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a7105f5f-c62b-4d7c-a435-a1c68e1eefe6; range_end:; response_count:1; response_revision:4709; }","duration":"194.579145ms","start":"2026-04-10T18:05:00.404835Z","end":"2026-04-10T18:05:00.599414Z","steps":["trace[518707569] 'agreement among raft nodes before linearized reading'  (duration: 194.314206ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-10T18:05:00.599327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:05:00.297095Z","time spent":"302.065205ms","remote":"127.0.0.1:51376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":881,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-6cfc8c4d5f-vpsbf.18a510fb37c83aef\" mod_revision:4650 > success:<request_put:<key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-6cfc8c4d5f-vpsbf.18a510fb37c83aef\" value_size:772 lease:4638036332296655543 >> failure:<request_range:<key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-6cfc8c4d5f-vpsbf.18a510fb37c83aef\" > >"}
{"level":"warn","ts":"2026-04-10T18:05:00.599532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:05:00.299236Z","time spent":"300.163628ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:4629 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-04-10T18:05:00.59963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.08778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-158061ae-5615-4c14-9a5d-9d1b658d312a\" ","response":"range_response_count:1 size:1435"}
{"level":"info","ts":"2026-04-10T18:05:00.599693Z","caller":"traceutil/trace.go:171","msg":"trace[327318371] range","detail":"{range_begin:/registry/persistentvolumes/pvc-158061ae-5615-4c14-9a5d-9d1b658d312a; range_end:; response_count:1; response_revision:4709; }","duration":"301.199433ms","start":"2026-04-10T18:05:00.298475Z","end":"2026-04-10T18:05:00.599675Z","steps":["trace[327318371] 'agreement among raft nodes before linearized reading'  (duration: 301.035518ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-10T18:05:00.599742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:05:00.298456Z","time spent":"301.272706ms","remote":"127.0.0.1:51444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1458,"request content":"key:\"/registry/persistentvolumes/pvc-158061ae-5615-4c14-9a5d-9d1b658d312a\" "}
{"level":"warn","ts":"2026-04-10T18:05:12.501191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.942758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"}
{"level":"info","ts":"2026-04-10T18:05:12.501297Z","caller":"traceutil/trace.go:171","msg":"trace[711072586] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4870; }","duration":"132.265919ms","start":"2026-04-10T18:05:12.369004Z","end":"2026-04-10T18:05:12.50127Z","steps":["trace[711072586] 'range keys from in-memory index tree'  (duration: 131.195208ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T18:05:12.701328Z","caller":"traceutil/trace.go:171","msg":"trace[1266511219] transaction","detail":"{read_only:false; response_revision:4871; number_of_response:1; }","duration":"187.531384ms","start":"2026-04-10T18:05:12.513756Z","end":"2026-04-10T18:05:12.701287Z","steps":["trace[1266511219] 'process raft request'  (duration: 187.320036ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T18:06:37.130446Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2872}
{"level":"info","ts":"2026-04-10T18:06:37.200955Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2872,"took":"69.170292ms","hash":2492864064,"current-db-size-bytes":53198848,"current-db-size":"53 MB","current-db-size-in-use-bytes":29155328,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-04-10T18:06:37.201026Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2492864064,"revision":2872,"compact-revision":-1}
{"level":"warn","ts":"2026-04-10T18:09:14.309429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.103042ms","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-10T18:09:14.309548Z","caller":"traceutil/trace.go:171","msg":"trace[84145263] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6646; }","duration":"196.268572ms","start":"2026-04-10T18:09:14.113258Z","end":"2026-04-10T18:09:14.309527Z","steps":["trace[84145263] 'range keys from in-memory index tree'  (duration: 195.901941ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-10T18:09:14.30982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.890711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-04-10T18:09:14.310037Z","caller":"traceutil/trace.go:171","msg":"trace[940010209] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6646; }","duration":"140.123634ms","start":"2026-04-10T18:09:14.169883Z","end":"2026-04-10T18:09:14.310007Z","steps":["trace[940010209] 'range keys from in-memory index tree'  (duration: 139.766074ms)"],"step_count":1}
{"level":"info","ts":"2026-04-10T18:11:37.135292Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5563}
{"level":"info","ts":"2026-04-10T18:11:37.205137Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5563,"took":"68.710221ms","hash":303348460,"current-db-size-bytes":53198848,"current-db-size":"53 MB","current-db-size-in-use-bytes":18231296,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-04-10T18:11:37.205189Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":303348460,"revision":5563,"compact-revision":2872}