{"level":"warn","ts":"2026-04-29T01:51:35.538256Z","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-29T01:51:35.538345Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.53: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.204.45.53:2380","--initial-cluster=instance=https://199.204.45.53:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.53:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.53: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-29T01:51:35.538431Z","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-29T01:51:35.538441Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.53:2380"]}
{"level":"info","ts":"2026-04-29T01:51:35.538468Z","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-29T01:51:35.539343Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"]}
{"level":"info","ts":"2026-04-29T01:51:35.53944Z","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.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.53: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-29T01:51:35.54525Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.518982ms"}
{"level":"info","ts":"2026-04-29T01:51:35.553845Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c47ca1a7b1fe506b","cluster-id":"95bd21e158fabf07"}
{"level":"info","ts":"2026-04-29T01:51:35.553926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=()"}
{"level":"info","ts":"2026-04-29T01:51:35.553951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 0"}
{"level":"info","ts":"2026-04-29T01:51:35.55396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c47ca1a7b1fe506b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-29T01:51:35.553971Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 1"}
{"level":"info","ts":"2026-04-29T01:51:35.554005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"}
{"level":"warn","ts":"2026-04-29T01:51:35.560051Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-29T01:51:35.561622Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-29T01:51:35.563824Z","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-29T01:51:35.566981Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c47ca1a7b1fe506b","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-29T01:51:35.567119Z","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-29T01:51:35.567198Z","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-29T01:51:35.567212Z","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-29T01:51:35.567878Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c47ca1a7b1fe506b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-29T01:51:35.56811Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"}
{"level":"info","ts":"2026-04-29T01:51:35.570564Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","added-peer-id":"c47ca1a7b1fe506b","added-peer-peer-urls":["https://199.204.45.53:2380"]}
{"level":"info","ts":"2026-04-29T01:51:35.57359Z","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-29T01:51:35.573695Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.53:2380"}
{"level":"info","ts":"2026-04-29T01:51:35.573773Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.53:2380"}
{"level":"info","ts":"2026-04-29T01:51:35.573841Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c47ca1a7b1fe506b","initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-29T01:51:35.573885Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-29T01:51:35.854741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b is starting a new election at term 1"}
{"level":"info","ts":"2026-04-29T01:51:35.854892Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-29T01:51:35.854979Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgPreVoteResp from c47ca1a7b1fe506b at term 1"}
{"level":"info","ts":"2026-04-29T01:51:35.855049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became candidate at term 2"}
{"level":"info","ts":"2026-04-29T01:51:35.855109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgVoteResp from c47ca1a7b1fe506b at term 2"}
{"level":"info","ts":"2026-04-29T01:51:35.855167Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became leader at term 2"}
{"level":"info","ts":"2026-04-29T01:51:35.855203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c47ca1a7b1fe506b elected leader c47ca1a7b1fe506b at term 2"}
{"level":"info","ts":"2026-04-29T01:51:35.855994Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c47ca1a7b1fe506b","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.53:2379]}","request-path":"/0/members/c47ca1a7b1fe506b/attributes","cluster-id":"95bd21e158fabf07","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-29T01:51:35.856321Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-29T01:51:35.856281Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-29T01:51:35.856985Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-29T01:51:35.857023Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-29T01:51:35.856987Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-29T01:51:35.857943Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-29T01:51:35.858044Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-29T01:51:35.858089Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-29T01:51:35.858848Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.53:2379"}
{"level":"info","ts":"2026-04-29T01:51:35.86135Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-29T01:52:05.320351Z","caller":"traceutil/trace.go:171","msg":"trace[1881145584] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"115.333566ms","start":"2026-04-29T01:52:05.204982Z","end":"2026-04-29T01:52:05.320315Z","steps":["trace[1881145584] 'process raft request'  (duration: 90.639091ms)","trace[1881145584] 'compare'  (duration: 24.525343ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-29T01:52:06.475982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.368551ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5794898892004427460 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/securitypolicies.gateway.envoyproxy.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/securitypolicies.gateway.envoyproxy.io\" value_size:207357 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-04-29T01:52:06.476208Z","caller":"traceutil/trace.go:171","msg":"trace[1922838080] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:619; }","duration":"172.230678ms","start":"2026-04-29T01:52:06.303961Z","end":"2026-04-29T01:52:06.476192Z","steps":["trace[1922838080] 'read index received'  (duration: 44.74709ms)","trace[1922838080] 'applied index is now lower than readState.Index'  (duration: 127.482568ms)"],"step_count":2}
{"level":"info","ts":"2026-04-29T01:52:06.476284Z","caller":"traceutil/trace.go:171","msg":"trace[655426668] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"176.822562ms","start":"2026-04-29T01:52:06.299451Z","end":"2026-04-29T01:52:06.476273Z","steps":["trace[655426668] 'process raft request'  (duration: 176.664971ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:52:06.476434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.46172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-04-29T01:52:06.476472Z","caller":"traceutil/trace.go:171","msg":"trace[1747654423] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:600; }","duration":"172.535422ms","start":"2026-04-29T01:52:06.303927Z","end":"2026-04-29T01:52:06.476462Z","steps":["trace[1747654423] 'agreement among raft nodes before linearized reading'  (duration: 172.460441ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:52:06.476429Z","caller":"traceutil/trace.go:171","msg":"trace[1411602544] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"182.238893ms","start":"2026-04-29T01:52:06.294168Z","end":"2026-04-29T01:52:06.476407Z","steps":["trace[1411602544] 'compare'  (duration: 171.119418ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:52:06.60007Z","caller":"traceutil/trace.go:171","msg":"trace[1376977154] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"130.568598ms","start":"2026-04-29T01:52:06.469489Z","end":"2026-04-29T01:52:06.600058Z","steps":["trace[1376977154] 'process raft request'  (duration: 126.750401ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:52:06.600093Z","caller":"traceutil/trace.go:171","msg":"trace[245155069] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"119.415223ms","start":"2026-04-29T01:52:06.480642Z","end":"2026-04-29T01:52:06.600057Z","steps":["trace[245155069] 'process raft request'  (duration: 119.240331ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:52:06.600182Z","caller":"traceutil/trace.go:171","msg":"trace[677127634] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"116.86664ms","start":"2026-04-29T01:52:06.483281Z","end":"2026-04-29T01:52:06.600147Z","steps":["trace[677127634] 'process raft request'  (duration: 116.646458ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:52:06.600384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.087238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-29T01:52:06.600437Z","caller":"traceutil/trace.go:171","msg":"trace[1865290397] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:604; }","duration":"207.187938ms","start":"2026-04-29T01:52:06.393237Z","end":"2026-04-29T01:52:06.600425Z","steps":["trace[1865290397] 'agreement among raft nodes before linearized reading'  (duration: 207.099848ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:52:06.600407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.462267ms","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-29T01:52:06.6Z","caller":"traceutil/trace.go:171","msg":"trace[973653265] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:621; }","duration":"123.709814ms","start":"2026-04-29T01:52:06.476248Z","end":"2026-04-29T01:52:06.599958Z","steps":["trace[973653265] 'read index received'  (duration: 8.431689ms)","trace[973653265] 'applied index is now lower than readState.Index'  (duration: 115.277405ms)"],"step_count":2}
{"level":"info","ts":"2026-04-29T01:52:06.600502Z","caller":"traceutil/trace.go:171","msg":"trace[1435402219] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:604; }","duration":"147.664749ms","start":"2026-04-29T01:52:06.452815Z","end":"2026-04-29T01:52:06.600479Z","steps":["trace[1435402219] 'agreement among raft nodes before linearized reading'  (duration: 147.343506ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:52:12.001419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.845934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-29T01:52:12.001525Z","caller":"traceutil/trace.go:171","msg":"trace[289699068] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:663; }","duration":"123.992125ms","start":"2026-04-29T01:52:11.877512Z","end":"2026-04-29T01:52:12.001504Z","steps":["trace[289699068] 'range keys from in-memory index tree'  (duration: 123.646903ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:52:12.756609Z","caller":"traceutil/trace.go:171","msg":"trace[1319778295] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"126.738159ms","start":"2026-04-29T01:52:12.629859Z","end":"2026-04-29T01:52:12.756597Z","steps":["trace[1319778295] 'process raft request'  (duration: 126.489907ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:52:12.756903Z","caller":"traceutil/trace.go:171","msg":"trace[1274727394] linearizableReadLoop","detail":"{readStateIndex:697; appliedIndex:696; }","duration":"121.20703ms","start":"2026-04-29T01:52:12.635248Z","end":"2026-04-29T01:52:12.756455Z","steps":["trace[1274727394] 'read index received'  (duration: 121.037629ms)","trace[1274727394] 'applied index is now lower than readState.Index'  (duration: 168.731µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-29T01:52:12.757118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.855457ms","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-29T01:52:12.757162Z","caller":"traceutil/trace.go:171","msg":"trace[1235320522] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:675; }","duration":"121.909627ms","start":"2026-04-29T01:52:12.635231Z","end":"2026-04-29T01:52:12.75714Z","steps":["trace[1235320522] 'agreement among raft nodes before linearized reading'  (duration: 121.700334ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:52:12.943874Z","caller":"traceutil/trace.go:171","msg":"trace[1957901387] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"114.595882ms","start":"2026-04-29T01:52:12.829239Z","end":"2026-04-29T01:52:12.943835Z","steps":["trace[1957901387] 'process raft request'  (duration: 110.579637ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:52:32.30285Z","caller":"traceutil/trace.go:171","msg":"trace[219472644] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"154.785658ms","start":"2026-04-29T01:52:32.148023Z","end":"2026-04-29T01:52:32.302808Z","steps":["trace[219472644] 'process raft request'  (duration: 154.650437ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:53:51.714954Z","caller":"traceutil/trace.go:171","msg":"trace[853790030] transaction","detail":"{read_only:false; response_revision:1884; number_of_response:1; }","duration":"353.595046ms","start":"2026-04-29T01:53:51.36131Z","end":"2026-04-29T01:53:51.714905Z","steps":["trace[853790030] 'process raft request'  (duration: 275.521316ms)","trace[853790030] 'compare'  (duration: 77.832055ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-29T01:53:51.715104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.844978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-29T01:53:51.715158Z","caller":"traceutil/trace.go:171","msg":"trace[1661787629] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1884; }","duration":"320.982011ms","start":"2026-04-29T01:53:51.39416Z","end":"2026-04-29T01:53:51.715142Z","steps":["trace[1661787629] 'agreement among raft nodes before linearized reading'  (duration: 320.868569ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:53:51.715201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T01:53:51.394096Z","time spent":"321.093953ms","remote":"127.0.0.1:56600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-29T01:53:51.714931Z","caller":"traceutil/trace.go:171","msg":"trace[249104534] linearizableReadLoop","detail":"{readStateIndex:1957; appliedIndex:1956; }","duration":"320.654014ms","start":"2026-04-29T01:53:51.394237Z","end":"2026-04-29T01:53:51.714891Z","steps":["trace[249104534] 'read index received'  (duration: 242.518963ms)","trace[249104534] 'applied index is now lower than readState.Index'  (duration: 78.133561ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-29T01:53:51.715374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T01:53:51.361287Z","time spent":"353.759129ms","remote":"127.0.0.1:56764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3728,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0781b4e6-792a-449a-8823-af822b58a546\" mod_revision:1847 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0781b4e6-792a-449a-8823-af822b58a546\" value_size:3628 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0781b4e6-792a-449a-8823-af822b58a546\" > >"}
{"level":"warn","ts":"2026-04-29T01:53:51.71561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.415368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-04-29T01:53:51.71574Z","caller":"traceutil/trace.go:171","msg":"trace[1152278209] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1884; }","duration":"109.594462ms","start":"2026-04-29T01:53:51.606123Z","end":"2026-04-29T01:53:51.715717Z","steps":["trace[1152278209] 'agreement among raft nodes before linearized reading'  (duration: 109.327106ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:53:51.715635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.130376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-04-29T01:53:51.717198Z","caller":"traceutil/trace.go:171","msg":"trace[1083661221] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1884; }","duration":"133.742949ms","start":"2026-04-29T01:53:51.583428Z","end":"2026-04-29T01:53:51.717171Z","steps":["trace[1083661221] 'agreement among raft nodes before linearized reading'  (duration: 132.011143ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:53:52.121485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.728996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0781b4e6-792a-449a-8823-af822b58a546\" ","response":"range_response_count:1 size:3743"}
{"level":"info","ts":"2026-04-29T01:53:52.121581Z","caller":"traceutil/trace.go:171","msg":"trace[673194200] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0781b4e6-792a-449a-8823-af822b58a546; range_end:; response_count:1; response_revision:1886; }","duration":"212.877099ms","start":"2026-04-29T01:53:51.908684Z","end":"2026-04-29T01:53:52.121561Z","steps":["trace[673194200] 'range keys from in-memory index tree'  (duration: 212.616673ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:54:21.021857Z","caller":"traceutil/trace.go:171","msg":"trace[1050202865] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"118.877431ms","start":"2026-04-29T01:54:20.902918Z","end":"2026-04-29T01:54:21.021796Z","steps":["trace[1050202865] 'process raft request'  (duration: 118.510145ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:54:21.544174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.844008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-29T01:54:21.54428Z","caller":"traceutil/trace.go:171","msg":"trace[948445040] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2105; }","duration":"150.025733ms","start":"2026-04-29T01:54:21.394227Z","end":"2026-04-29T01:54:21.544253Z","steps":["trace[948445040] 'range keys from in-memory index tree'  (duration: 149.739997ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:54:21.651354Z","caller":"traceutil/trace.go:171","msg":"trace[1021480820] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"101.648053ms","start":"2026-04-29T01:54:21.549673Z","end":"2026-04-29T01:54:21.651321Z","steps":["trace[1021480820] 'process raft request'  (duration: 100.825269ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:54:21.786975Z","caller":"traceutil/trace.go:171","msg":"trace[13016177] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"236.708153ms","start":"2026-04-29T01:54:21.550221Z","end":"2026-04-29T01:54:21.786929Z","steps":["trace[13016177] 'process raft request'  (duration: 204.936171ms)","trace[13016177] 'compare'  (duration: 31.396896ms)"],"step_count":2}
{"level":"info","ts":"2026-04-29T01:54:22.436332Z","caller":"traceutil/trace.go:171","msg":"trace[2084899577] transaction","detail":"{read_only:false; response_revision:2110; number_of_response:1; }","duration":"199.347526ms","start":"2026-04-29T01:54:22.236927Z","end":"2026-04-29T01:54:22.436275Z","steps":["trace[2084899577] 'process raft request'  (duration: 199.029851ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:54:23.134826Z","caller":"traceutil/trace.go:171","msg":"trace[99362962] linearizableReadLoop","detail":"{readStateIndex:2195; appliedIndex:2194; }","duration":"106.423039ms","start":"2026-04-29T01:54:23.028372Z","end":"2026-04-29T01:54:23.134795Z","steps":["trace[99362962] 'read index received'  (duration: 106.099274ms)","trace[99362962] 'applied index is now lower than readState.Index'  (duration: 322.625µs)"],"step_count":2}
{"level":"info","ts":"2026-04-29T01:54:23.135001Z","caller":"traceutil/trace.go:171","msg":"trace[1491537350] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"366.46763ms","start":"2026-04-29T01:54:22.76852Z","end":"2026-04-29T01:54:23.134988Z","steps":["trace[1491537350] 'process raft request'  (duration: 366.065633ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:54:23.135244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T01:54:22.768488Z","time spent":"366.622923ms","remote":"127.0.0.1:56848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:2068 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-04-29T01:54:23.13543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.027409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-29T01:54:23.135542Z","caller":"traceutil/trace.go:171","msg":"trace[578626010] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2115; }","duration":"107.197541ms","start":"2026-04-29T01:54:23.028319Z","end":"2026-04-29T01:54:23.135517Z","steps":["trace[578626010] 'agreement among raft nodes before linearized reading'  (duration: 106.885375ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:54:23.382283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.685042ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5794898892004430560 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2104 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-29T01:54:23.382454Z","caller":"traceutil/trace.go:171","msg":"trace[322299078] linearizableReadLoop","detail":"{readStateIndex:2196; appliedIndex:2195; }","duration":"137.920418ms","start":"2026-04-29T01:54:23.244479Z","end":"2026-04-29T01:54:23.3824Z","steps":["trace[322299078] 'read index received'  (duration: 21.792799ms)","trace[322299078] 'applied index is now lower than readState.Index'  (duration: 116.125559ms)"],"step_count":2}
{"level":"info","ts":"2026-04-29T01:54:23.382459Z","caller":"traceutil/trace.go:171","msg":"trace[1948748448] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"241.737844ms","start":"2026-04-29T01:54:23.140688Z","end":"2026-04-29T01:54:23.382426Z","steps":["trace[1948748448] 'process raft request'  (duration: 125.592414ms)","trace[1948748448] 'compare'  (duration: 115.232284ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-29T01:54:23.382619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.119452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-29T01:54:23.382969Z","caller":"traceutil/trace.go:171","msg":"trace[911080053] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:2116; }","duration":"138.508668ms","start":"2026-04-29T01:54:23.244421Z","end":"2026-04-29T01:54:23.38293Z","steps":["trace[911080053] 'agreement among raft nodes before linearized reading'  (duration: 138.084271ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:54:23.431478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.345089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-29T01:54:23.431597Z","caller":"traceutil/trace.go:171","msg":"trace[1156434234] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:2117; }","duration":"137.516161ms","start":"2026-04-29T01:54:23.294056Z","end":"2026-04-29T01:54:23.431572Z","steps":["trace[1156434234] 'agreement among raft nodes before linearized reading'  (duration: 137.282348ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:55:34.533953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.268546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-29T01:55:34.534014Z","caller":"traceutil/trace.go:171","msg":"trace[2033241051] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2600; }","duration":"142.380917ms","start":"2026-04-29T01:55:34.391621Z","end":"2026-04-29T01:55:34.534002Z","steps":["trace[2033241051] 'agreement among raft nodes before linearized reading'  (duration: 142.269076ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:55:34.533782Z","caller":"traceutil/trace.go:171","msg":"trace[135853698] linearizableReadLoop","detail":"{readStateIndex:2697; appliedIndex:2696; }","duration":"142.064853ms","start":"2026-04-29T01:55:34.39169Z","end":"2026-04-29T01:55:34.533755Z","steps":["trace[135853698] 'read index received'  (duration: 126.312465ms)","trace[135853698] 'applied index is now lower than readState.Index'  (duration: 15.751038ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-29T01:56:07.218951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.580059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-04-29T01:56:07.219238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.76043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-04-29T01:56:07.21965Z","caller":"traceutil/trace.go:171","msg":"trace[181591025] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2780; }","duration":"131.243946ms","start":"2026-04-29T01:56:07.088357Z","end":"2026-04-29T01:56:07.219601Z","steps":["trace[181591025] 'range keys from in-memory index tree'  (duration: 130.580378ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:56:07.219577Z","caller":"traceutil/trace.go:171","msg":"trace[1413021934] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2780; }","duration":"142.203507ms","start":"2026-04-29T01:56:07.077292Z","end":"2026-04-29T01:56:07.219496Z","steps":["trace[1413021934] 'range keys from in-memory index tree'  (duration: 141.357297ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:56:12.461546Z","caller":"traceutil/trace.go:171","msg":"trace[1619524240] linearizableReadLoop","detail":"{readStateIndex:2913; appliedIndex:2912; }","duration":"117.342831ms","start":"2026-04-29T01:56:12.344188Z","end":"2026-04-29T01:56:12.461531Z","steps":["trace[1619524240] 'read index received'  (duration: 117.265151ms)","trace[1619524240] 'applied index is now lower than readState.Index'  (duration: 76.91µs)"],"step_count":2}
{"level":"info","ts":"2026-04-29T01:56:12.461607Z","caller":"traceutil/trace.go:171","msg":"trace[1367467882] transaction","detail":"{read_only:false; response_revision:2808; number_of_response:1; }","duration":"122.096443ms","start":"2026-04-29T01:56:12.339478Z","end":"2026-04-29T01:56:12.461574Z","steps":["trace[1367467882] 'process raft request'  (duration: 121.954541ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:56:12.461753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.522513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-04-29T01:56:12.46178Z","caller":"traceutil/trace.go:171","msg":"trace[139075225] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2808; }","duration":"117.633074ms","start":"2026-04-29T01:56:12.34414Z","end":"2026-04-29T01:56:12.461774Z","steps":["trace[139075225] 'agreement among raft nodes before linearized reading'  (duration: 117.461402ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:59:56.600885Z","caller":"traceutil/trace.go:171","msg":"trace[1241932814] transaction","detail":"{read_only:false; response_revision:4688; number_of_response:1; }","duration":"152.75402ms","start":"2026-04-29T01:59:56.448109Z","end":"2026-04-29T01:59:56.600863Z","steps":["trace[1241932814] 'process raft request'  (duration: 150.449257ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:59:56.60098Z","caller":"traceutil/trace.go:171","msg":"trace[445722445] transaction","detail":"{read_only:false; response_revision:4690; number_of_response:1; }","duration":"150.898434ms","start":"2026-04-29T01:59:56.450055Z","end":"2026-04-29T01:59:56.600953Z","steps":["trace[445722445] 'process raft request'  (duration: 150.800042ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:59:56.601085Z","caller":"traceutil/trace.go:171","msg":"trace[1661891920] transaction","detail":"{read_only:false; response_revision:4691; number_of_response:1; }","duration":"150.852713ms","start":"2026-04-29T01:59:56.450217Z","end":"2026-04-29T01:59:56.601069Z","steps":["trace[1661891920] 'process raft request'  (duration: 150.669259ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:59:56.601202Z","caller":"traceutil/trace.go:171","msg":"trace[2091440186] transaction","detail":"{read_only:false; response_revision:4689; number_of_response:1; }","duration":"151.162659ms","start":"2026-04-29T01:59:56.450028Z","end":"2026-04-29T01:59:56.60119Z","steps":["trace[2091440186] 'process raft request'  (duration: 150.787412ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T02:00:01.842549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.067784ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5794898892004437045 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/monitoring/prometheus-kube-prometheus-stack-prometheus-0.18aab159abfbdb48\" mod_revision:0 > success:<request_put:<key:\"/registry/events/monitoring/prometheus-kube-prometheus-stack-prometheus-0.18aab159abfbdb48\" value_size:706 lease:5794898892004436778 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-04-29T02:00:01.842631Z","caller":"traceutil/trace.go:171","msg":"trace[1689730806] linearizableReadLoop","detail":"{readStateIndex:4972; appliedIndex:4971; }","duration":"189.938235ms","start":"2026-04-29T02:00:01.652679Z","end":"2026-04-29T02:00:01.842617Z","steps":["trace[1689730806] 'read index received'  (duration: 24.692487ms)","trace[1689730806] 'applied index is now lower than readState.Index'  (duration: 165.244968ms)"],"step_count":2}
{"level":"info","ts":"2026-04-29T02:00:01.842712Z","caller":"traceutil/trace.go:171","msg":"trace[900219547] transaction","detail":"{read_only:false; response_revision:4789; number_of_response:1; }","duration":"193.9357ms","start":"2026-04-29T02:00:01.648768Z","end":"2026-04-29T02:00:01.842704Z","steps":["trace[900219547] 'process raft request'  (duration: 28.653652ms)","trace[900219547] 'compare'  (duration: 164.964661ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-29T02:00:01.842957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.272131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-txc8j\" ","response":"range_response_count:1 size:5150"}
{"level":"info","ts":"2026-04-29T02:00:01.842984Z","caller":"traceutil/trace.go:171","msg":"trace[1206757885] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-txc8j; range_end:; response_count:1; response_revision:4789; }","duration":"190.328781ms","start":"2026-04-29T02:00:01.652648Z","end":"2026-04-29T02:00:01.842977Z","steps":["trace[1206757885] 'agreement among raft nodes before linearized reading'  (duration: 190.195289ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T02:00:01.859004Z","caller":"traceutil/trace.go:171","msg":"trace[988342934] transaction","detail":"{read_only:false; response_revision:4790; number_of_response:1; }","duration":"114.328497ms","start":"2026-04-29T02:00:01.744655Z","end":"2026-04-29T02:00:01.858984Z","steps":["trace[988342934] 'process raft request'  (duration: 114.217055ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T02:00:02.042841Z","caller":"traceutil/trace.go:171","msg":"trace[652684272] transaction","detail":"{read_only:false; response_revision:4793; number_of_response:1; }","duration":"191.156675ms","start":"2026-04-29T02:00:01.851611Z","end":"2026-04-29T02:00:02.042768Z","steps":["trace[652684272] 'process raft request'  (duration: 190.786118ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T02:00:02.042969Z","caller":"traceutil/trace.go:171","msg":"trace[1694879788] linearizableReadLoop","detail":"{readStateIndex:4975; appliedIndex:4972; }","duration":"200.301267ms","start":"2026-04-29T02:00:01.842655Z","end":"2026-04-29T02:00:02.042956Z","steps":["trace[1694879788] 'read index received'  (duration: 16.255656ms)","trace[1694879788] 'applied index is now lower than readState.Index'  (duration: 184.042311ms)"],"step_count":2}
{"level":"info","ts":"2026-04-29T02:00:02.042933Z","caller":"traceutil/trace.go:171","msg":"trace[525064707] transaction","detail":"{read_only:false; response_revision:4791; number_of_response:1; }","duration":"276.591977ms","start":"2026-04-29T02:00:01.766298Z","end":"2026-04-29T02:00:02.04289Z","steps":["trace[525064707] 'process raft request'  (duration: 178.290184ms)","trace[525064707] 'compare'  (duration: 97.625781ms)"],"step_count":2}
{"level":"info","ts":"2026-04-29T02:00:02.043153Z","caller":"traceutil/trace.go:171","msg":"trace[1811074059] transaction","detail":"{read_only:false; response_revision:4794; number_of_response:1; }","duration":"177.208292ms","start":"2026-04-29T02:00:01.865933Z","end":"2026-04-29T02:00:02.043141Z","steps":["trace[1811074059] 'process raft request'  (duration: 176.527799ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T02:00:02.043098Z","caller":"traceutil/trace.go:171","msg":"trace[1513130342] transaction","detail":"{read_only:false; response_revision:4792; number_of_response:1; }","duration":"270.138105ms","start":"2026-04-29T02:00:01.772924Z","end":"2026-04-29T02:00:02.043062Z","steps":["trace[1513130342] 'process raft request'  (duration: 269.430212ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T02:00:02.043401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.364925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-04-29T02:00:02.04347Z","caller":"traceutil/trace.go:171","msg":"trace[623525655] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4795; }","duration":"115.491507ms","start":"2026-04-29T02:00:01.927964Z","end":"2026-04-29T02:00:02.043455Z","steps":["trace[623525655] 'agreement among raft nodes before linearized reading'  (duration: 115.282183ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T02:00:02.043492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.674468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-04-29T02:00:02.04358Z","caller":"traceutil/trace.go:171","msg":"trace[2049307701] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4795; }","duration":"356.79438ms","start":"2026-04-29T02:00:01.686763Z","end":"2026-04-29T02:00:02.043557Z","steps":["trace[2049307701] 'agreement among raft nodes before linearized reading'  (duration: 356.523415ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T02:00:02.043645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T02:00:01.686745Z","time spent":"356.888922ms","remote":"127.0.0.1:56848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-04-29T02:00:15.06328Z","caller":"traceutil/trace.go:171","msg":"trace[2000773951] linearizableReadLoop","detail":"{readStateIndex:5130; appliedIndex:5129; }","duration":"361.071264ms","start":"2026-04-29T02:00:14.702183Z","end":"2026-04-29T02:00:15.063254Z","steps":["trace[2000773951] 'read index received'  (duration: 360.881581ms)","trace[2000773951] 'applied index is now lower than readState.Index'  (duration: 188.813µs)"],"step_count":2}
{"level":"info","ts":"2026-04-29T02:00:15.063381Z","caller":"traceutil/trace.go:171","msg":"trace[1801760911] transaction","detail":"{read_only:false; response_revision:4942; number_of_response:1; }","duration":"366.220108ms","start":"2026-04-29T02:00:14.697131Z","end":"2026-04-29T02:00:15.063351Z","steps":["trace[1801760911] 'process raft request'  (duration: 365.991634ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T02:00:15.063527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T02:00:14.697107Z","time spent":"366.335051ms","remote":"127.0.0.1:56848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:4923 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-04-29T02:00:15.063572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.368469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-04-29T02:00:15.063619Z","caller":"traceutil/trace.go:171","msg":"trace[984897655] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4942; }","duration":"361.553053ms","start":"2026-04-29T02:00:14.702054Z","end":"2026-04-29T02:00:15.063607Z","steps":["trace[984897655] 'agreement among raft nodes before linearized reading'  (duration: 361.38797ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T02:00:15.063662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T02:00:14.702041Z","time spent":"361.608983ms","remote":"127.0.0.1:56848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-29T02:00:15.063934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.141214ms","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-29T02:00:15.064072Z","caller":"traceutil/trace.go:171","msg":"trace[1486172151] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4942; }","duration":"356.321727ms","start":"2026-04-29T02:00:14.707735Z","end":"2026-04-29T02:00:15.064057Z","steps":["trace[1486172151] 'agreement among raft nodes before linearized reading'  (duration: 355.806537ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T02:00:15.064166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T02:00:14.70772Z","time spent":"356.415949ms","remote":"127.0.0.1:56848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-04-29T02:00:15.169975Z","caller":"traceutil/trace.go:171","msg":"trace[783330437] transaction","detail":"{read_only:false; response_revision:4944; number_of_response:1; }","duration":"100.732516ms","start":"2026-04-29T02:00:15.069206Z","end":"2026-04-29T02:00:15.169938Z","steps":["trace[783330437] 'process raft request'  (duration: 30.921094ms)","trace[783330437] 'compare'  (duration: 69.65133ms)"],"step_count":2}
{"level":"info","ts":"2026-04-29T02:00:15.454005Z","caller":"traceutil/trace.go:171","msg":"trace[1838310456] transaction","detail":"{read_only:false; response_revision:4947; number_of_response:1; }","duration":"106.738215ms","start":"2026-04-29T02:00:15.347221Z","end":"2026-04-29T02:00:15.453959Z","steps":["trace[1838310456] 'process raft request'  (duration: 106.563872ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T02:00:52.486659Z","caller":"traceutil/trace.go:171","msg":"trace[518893910] transaction","detail":"{read_only:false; response_revision:5286; number_of_response:1; }","duration":"207.93458ms","start":"2026-04-29T02:00:52.2787Z","end":"2026-04-29T02:00:52.486635Z","steps":["trace[518893910] 'process raft request'  (duration: 207.719106ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T02:00:52.498041Z","caller":"traceutil/trace.go:171","msg":"trace[1205459460] linearizableReadLoop","detail":"{readStateIndex:5483; appliedIndex:5481; }","duration":"158.104111ms","start":"2026-04-29T02:00:52.339917Z","end":"2026-04-29T02:00:52.498021Z","steps":["trace[1205459460] 'read index received'  (duration: 146.536676ms)","trace[1205459460] 'applied index is now lower than readState.Index'  (duration: 11.566795ms)"],"step_count":2}
{"level":"info","ts":"2026-04-29T02:00:52.498188Z","caller":"traceutil/trace.go:171","msg":"trace[952855120] transaction","detail":"{read_only:false; response_revision:5287; number_of_response:1; }","duration":"214.559542ms","start":"2026-04-29T02:00:52.28361Z","end":"2026-04-29T02:00:52.498169Z","steps":["trace[952855120] 'process raft request'  (duration: 214.299788ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T02:00:52.49845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.508447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-04-29T02:00:52.498517Z","caller":"traceutil/trace.go:171","msg":"trace[2062445803] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5287; }","duration":"158.6236ms","start":"2026-04-29T02:00:52.339876Z","end":"2026-04-29T02:00:52.498499Z","steps":["trace[2062445803] 'agreement among raft nodes before linearized reading'  (duration: 158.261033ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T02:01:35.945187Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2930}
{"level":"info","ts":"2026-04-29T02:01:36.030161Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2930,"took":"82.928068ms","hash":702789625,"current-db-size-bytes":52822016,"current-db-size":"53 MB","current-db-size-in-use-bytes":29089792,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-04-29T02:01:36.030216Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":702789625,"revision":2930,"compact-revision":-1}
{"level":"info","ts":"2026-04-29T02:03:54.793977Z","caller":"traceutil/trace.go:171","msg":"trace[1026012303] transaction","detail":"{read_only:false; response_revision:6560; number_of_response:1; }","duration":"140.249829ms","start":"2026-04-29T02:03:54.653689Z","end":"2026-04-29T02:03:54.793939Z","steps":["trace[1026012303] 'process raft request'  (duration: 140.065436ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T02:06:35.949767Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5601}
{"level":"info","ts":"2026-04-29T02:06:36.01842Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5601,"took":"67.45623ms","hash":3236007129,"current-db-size-bytes":52822016,"current-db-size":"53 MB","current-db-size-in-use-bytes":18354176,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-04-29T02:06:36.018472Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3236007129,"revision":5601,"compact-revision":2930}