{"level":"warn","ts":"2026-04-17T00:32:02.486149Z","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-17T00:32:02.486237Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.248: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.248:2380","--initial-cluster=instance=https://199.204.45.248:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.248:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.248: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-17T00:32:02.486303Z","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-17T00:32:02.48633Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-04-17T00:32:02.486348Z","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-17T00:32:02.487026Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"]} {"level":"info","ts":"2026-04-17T00:32:02.487095Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.248: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-17T00:32:02.492773Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.465578ms"} {"level":"info","ts":"2026-04-17T00:32:02.503484Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39582465ceaa2f67","cluster-id":"87fd8ddedde3be45"} {"level":"info","ts":"2026-04-17T00:32:02.503633Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=()"} {"level":"info","ts":"2026-04-17T00:32:02.503675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 0"} {"level":"info","ts":"2026-04-17T00:32:02.503697Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39582465ceaa2f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-17T00:32:02.503711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 1"} {"level":"info","ts":"2026-04-17T00:32:02.503772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"warn","ts":"2026-04-17T00:32:02.515732Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-17T00:32:02.518543Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-17T00:32:02.519671Z","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-17T00:32:02.521675Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39582465ceaa2f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-17T00:32:02.521853Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39582465ceaa2f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-17T00:32:02.521982Z","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-17T00:32:02.522074Z","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-17T00:32:02.522101Z","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-17T00:32:02.522906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"info","ts":"2026-04-17T00:32:02.523105Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","added-peer-id":"39582465ceaa2f67","added-peer-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-04-17T00:32:02.524515Z","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-17T00:32:02.524597Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-04-17T00:32:02.524644Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-04-17T00:32:02.524749Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39582465ceaa2f67","initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-17T00:32:02.524794Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-17T00:32:03.105019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 is starting a new election at term 1"} {"level":"info","ts":"2026-04-17T00:32:03.105117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-17T00:32:03.105147Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgPreVoteResp from 39582465ceaa2f67 at term 1"} {"level":"info","ts":"2026-04-17T00:32:03.105169Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became candidate at term 2"} {"level":"info","ts":"2026-04-17T00:32:03.105185Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgVoteResp from 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-04-17T00:32:03.105207Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became leader at term 2"} {"level":"info","ts":"2026-04-17T00:32:03.105225Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39582465ceaa2f67 elected leader 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-04-17T00:32:03.10637Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T00:32:03.107287Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T00:32:03.107272Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39582465ceaa2f67","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.248:2379]}","request-path":"/0/members/39582465ceaa2f67/attributes","cluster-id":"87fd8ddedde3be45","publish-timeout":"7s"} {"level":"info","ts":"2026-04-17T00:32:03.107342Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T00:32:03.107647Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-17T00:32:03.107735Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-17T00:32:03.107752Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T00:32:03.107902Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T00:32:03.107945Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T00:32:03.110817Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.248:2379"} {"level":"info","ts":"2026-04-17T00:32:03.111576Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-17T00:32:38.262569Z","caller":"traceutil/trace.go:171","msg":"trace[1516424162] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"227.019907ms","start":"2026-04-17T00:32:38.035515Z","end":"2026-04-17T00:32:38.262535Z","steps":["trace[1516424162] 'process raft request' (duration: 226.68001ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:32:38.519128Z","caller":"traceutil/trace.go:171","msg":"trace[1737272107] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"169.278684ms","start":"2026-04-17T00:32:38.349821Z","end":"2026-04-17T00:32:38.5191Z","steps":["trace[1737272107] 'process raft request' (duration: 168.733363ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:32:38.980292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.849929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:32:38.980422Z","caller":"traceutil/trace.go:171","msg":"trace[193886818] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:614; }","duration":"448.061194ms","start":"2026-04-17T00:32:38.532337Z","end":"2026-04-17T00:32:38.980399Z","steps":["trace[193886818] 'range keys from in-memory index tree' (duration: 447.721967ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:32:38.98051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:32:38.532311Z","time spent":"448.187837ms","remote":"127.0.0.1:57814","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-17T00:32:38.988937Z","caller":"traceutil/trace.go:171","msg":"trace[467974040] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"408.339879ms","start":"2026-04-17T00:32:38.580569Z","end":"2026-04-17T00:32:38.988909Z","steps":["trace[467974040] 'process raft request' (duration: 408.197766ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:32:38.989621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:32:38.580537Z","time spent":"408.478552ms","remote":"127.0.0.1:58312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T00:32:39.004938Z","caller":"traceutil/trace.go:171","msg":"trace[1121937088] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"291.540765ms","start":"2026-04-17T00:32:38.713383Z","end":"2026-04-17T00:32:39.004923Z","steps":["trace[1121937088] 'process raft request' (duration: 291.355351ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:32:39.004924Z","caller":"traceutil/trace.go:171","msg":"trace[836241305] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:636; }","duration":"290.095023ms","start":"2026-04-17T00:32:38.714801Z","end":"2026-04-17T00:32:39.004896Z","steps":["trace[836241305] 'read index received' (duration: 273.948547ms)","trace[836241305] 'applied index is now lower than readState.Index' (duration: 16.145146ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:32:39.005094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.268138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-17T00:32:39.005145Z","caller":"traceutil/trace.go:171","msg":"trace[1630734840] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:617; }","duration":"290.384459ms","start":"2026-04-17T00:32:38.714747Z","end":"2026-04-17T00:32:39.005131Z","steps":["trace[1630734840] 'agreement among raft nodes before linearized reading' (duration: 290.218786ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:32:39.005117Z","caller":"traceutil/trace.go:171","msg":"trace[758864071] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"114.221197ms","start":"2026-04-17T00:32:38.890862Z","end":"2026-04-17T00:32:39.005083Z","steps":["trace[758864071] 'process raft request' (duration: 113.992832ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:32:39.00534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.480336ms","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-17T00:32:39.005377Z","caller":"traceutil/trace.go:171","msg":"trace[2004422819] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:617; }","duration":"155.539698ms","start":"2026-04-17T00:32:38.849829Z","end":"2026-04-17T00:32:39.005369Z","steps":["trace[2004422819] 'agreement among raft nodes before linearized reading' (duration: 155.450135ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:32:39.005275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.708652ms","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-17T00:32:39.005461Z","caller":"traceutil/trace.go:171","msg":"trace[250844737] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:617; }","duration":"254.892226ms","start":"2026-04-17T00:32:38.750525Z","end":"2026-04-17T00:32:39.005418Z","steps":["trace[250844737] 'agreement among raft nodes before linearized reading' (duration: 254.604329ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:32:40.278004Z","caller":"traceutil/trace.go:171","msg":"trace[1185805572] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:662; }","duration":"101.917095ms","start":"2026-04-17T00:32:40.176052Z","end":"2026-04-17T00:32:40.277969Z","steps":["trace[1185805572] 'read index received' (duration: 101.608788ms)","trace[1185805572] 'applied index is now lower than readState.Index' (duration: 306.907µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:32:40.278109Z","caller":"traceutil/trace.go:171","msg":"trace[6417272] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"106.445981ms","start":"2026-04-17T00:32:40.17159Z","end":"2026-04-17T00:32:40.278036Z","steps":["trace[6417272] 'process raft request' (duration: 106.098924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:32:40.278508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.402925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:32:40.278608Z","caller":"traceutil/trace.go:171","msg":"trace[1932210158] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:0; response_revision:641; }","duration":"102.551358ms","start":"2026-04-17T00:32:40.176029Z","end":"2026-04-17T00:32:40.278581Z","steps":["trace[1932210158] 'agreement among raft nodes before linearized reading' (duration: 102.125869ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:32:40.285535Z","caller":"traceutil/trace.go:171","msg":"trace[2090549584] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"109.415015ms","start":"2026-04-17T00:32:40.176082Z","end":"2026-04-17T00:32:40.285497Z","steps":["trace[2090549584] 'process raft request' (duration: 109.290582ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:32:40.285588Z","caller":"traceutil/trace.go:171","msg":"trace[1611637619] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"109.22057ms","start":"2026-04-17T00:32:40.176344Z","end":"2026-04-17T00:32:40.285564Z","steps":["trace[1611637619] 'process raft request' (duration: 109.133838ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:32:40.285628Z","caller":"traceutil/trace.go:171","msg":"trace[352880755] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"109.418286ms","start":"2026-04-17T00:32:40.176183Z","end":"2026-04-17T00:32:40.285601Z","steps":["trace[352880755] 'process raft request' (duration: 109.258482ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:32:40.285635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.1506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T00:32:40.285583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.412695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:32:40.285771Z","caller":"traceutil/trace.go:171","msg":"trace[318392890] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:644; }","duration":"109.59982ms","start":"2026-04-17T00:32:40.17614Z","end":"2026-04-17T00:32:40.28574Z","steps":["trace[318392890] 'agreement among raft nodes before linearized reading' (duration: 109.374935ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:32:40.285787Z","caller":"traceutil/trace.go:171","msg":"trace[566551624] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:644; }","duration":"109.326073ms","start":"2026-04-17T00:32:40.176444Z","end":"2026-04-17T00:32:40.28577Z","steps":["trace[566551624] 'agreement among raft nodes before linearized reading' (duration: 109.16975ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:32:40.285762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.501398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:32:40.285915Z","caller":"traceutil/trace.go:171","msg":"trace[96296050] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:644; }","duration":"109.635761ms","start":"2026-04-17T00:32:40.176214Z","end":"2026-04-17T00:32:40.28585Z","steps":["trace[96296050] 'agreement among raft nodes before linearized reading' (duration: 109.451477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:34:07.850758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.741777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:34:07.850937Z","caller":"traceutil/trace.go:171","msg":"trace[1495367622] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1837; }","duration":"111.969812ms","start":"2026-04-17T00:34:07.738931Z","end":"2026-04-17T00:34:07.850901Z","steps":["trace[1495367622] 'count revisions from in-memory index tree' (duration: 111.633114ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:34:07.850781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.577796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-17T00:34:07.851181Z","caller":"traceutil/trace.go:171","msg":"trace[1614806372] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1837; }","duration":"172.064288ms","start":"2026-04-17T00:34:07.679097Z","end":"2026-04-17T00:34:07.851162Z","steps":["trace[1614806372] 'range keys from in-memory index tree' (duration: 171.36157ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:34:53.355641Z","caller":"traceutil/trace.go:171","msg":"trace[649195344] linearizableReadLoop","detail":"{readStateIndex:2208; appliedIndex:2207; }","duration":"551.069567ms","start":"2026-04-17T00:34:52.804539Z","end":"2026-04-17T00:34:53.355609Z","steps":["trace[649195344] 'read index received' (duration: 459.038921ms)","trace[649195344] 'applied index is now lower than readState.Index' (duration: 92.029736ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:34:53.355726Z","caller":"traceutil/trace.go:171","msg":"trace[2085439514] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"562.117219ms","start":"2026-04-17T00:34:52.79357Z","end":"2026-04-17T00:34:53.355687Z","steps":["trace[2085439514] 'process raft request' (duration: 470.081403ms)","trace[2085439514] 'compare' (duration: 91.854261ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:34:53.355823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.254861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T00:34:53.355909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.556534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-17T00:34:53.355911Z","caller":"traceutil/trace.go:171","msg":"trace[662358853] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:2129; }","duration":"551.386064ms","start":"2026-04-17T00:34:52.804506Z","end":"2026-04-17T00:34:53.355892Z","steps":["trace[662358853] 'agreement among raft nodes before linearized reading' (duration: 551.244881ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:34:53.355945Z","caller":"traceutil/trace.go:171","msg":"trace[1527664768] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2129; }","duration":"317.630466ms","start":"2026-04-17T00:34:53.038305Z","end":"2026-04-17T00:34:53.355935Z","steps":["trace[1527664768] 'agreement among raft nodes before linearized reading' (duration: 317.476193ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:34:53.355971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:34:52.804495Z","time spent":"551.457716ms","remote":"127.0.0.1:53100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-17T00:34:53.355995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:34:53.038287Z","time spent":"317.698387ms","remote":"127.0.0.1:58102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-17T00:34:53.356101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.532639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"} {"level":"warn","ts":"2026-04-17T00:34:53.356137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:34:52.793548Z","time spent":"562.263021ms","remote":"127.0.0.1:58102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:34:53.356195Z","caller":"traceutil/trace.go:171","msg":"trace[865456574] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2129; }","duration":"312.666151ms","start":"2026-04-17T00:34:53.043503Z","end":"2026-04-17T00:34:53.356169Z","steps":["trace[865456574] 'agreement among raft nodes before linearized reading' (duration: 312.414366ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:34:53.356247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:34:53.043483Z","time spent":"312.750134ms","remote":"127.0.0.1:58102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":593,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-04-17T00:34:53.356159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.763483ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:34:53.356329Z","caller":"traceutil/trace.go:171","msg":"trace[1431626917] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2128; }","duration":"406.669023ms","start":"2026-04-17T00:34:52.949629Z","end":"2026-04-17T00:34:53.356298Z","steps":["trace[1431626917] 'range keys from in-memory index tree' (duration: 405.737331ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:34:53.356604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.431952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-17T00:34:53.356701Z","caller":"traceutil/trace.go:171","msg":"trace[673081834] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2129; }","duration":"150.573295ms","start":"2026-04-17T00:34:53.206101Z","end":"2026-04-17T00:34:53.356675Z","steps":["trace[673081834] 'agreement among raft nodes before linearized reading' (duration: 149.903489ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:36:17.105944Z","caller":"traceutil/trace.go:171","msg":"trace[1617046502] linearizableReadLoop","detail":"{readStateIndex:2733; appliedIndex:2732; }","duration":"123.623456ms","start":"2026-04-17T00:36:16.982288Z","end":"2026-04-17T00:36:17.105911Z","steps":["trace[1617046502] 'read index received' (duration: 123.439622ms)","trace[1617046502] 'applied index is now lower than readState.Index' (duration: 182.454µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:36:17.106011Z","caller":"traceutil/trace.go:171","msg":"trace[250109417] transaction","detail":"{read_only:false; response_revision:2635; number_of_response:1; }","duration":"170.79935ms","start":"2026-04-17T00:36:16.935158Z","end":"2026-04-17T00:36:17.105958Z","steps":["trace[250109417] 'process raft request' (duration: 170.558175ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:36:17.106255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.949483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1366"} {"level":"info","ts":"2026-04-17T00:36:17.106324Z","caller":"traceutil/trace.go:171","msg":"trace[1351616724] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2635; }","duration":"124.065956ms","start":"2026-04-17T00:36:16.982243Z","end":"2026-04-17T00:36:17.106309Z","steps":["trace[1351616724] 'agreement among raft nodes before linearized reading' (duration: 123.841881ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:38:28.586125Z","caller":"traceutil/trace.go:171","msg":"trace[1276683073] transaction","detail":"{read_only:false; response_revision:3438; number_of_response:1; }","duration":"101.058192ms","start":"2026-04-17T00:38:28.485022Z","end":"2026-04-17T00:38:28.586081Z","steps":["trace[1276683073] 'process raft request' (duration: 86.938837ms)","trace[1276683073] 'compare' (duration: 13.832199ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:40:26.897342Z","caller":"traceutil/trace.go:171","msg":"trace[1319901018] linearizableReadLoop","detail":"{readStateIndex:5019; appliedIndex:5018; }","duration":"102.795025ms","start":"2026-04-17T00:40:26.794513Z","end":"2026-04-17T00:40:26.897308Z","steps":["trace[1319901018] 'read index received' (duration: 102.516649ms)","trace[1319901018] 'applied index is now lower than readState.Index' (duration: 276.836µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:40:26.897512Z","caller":"traceutil/trace.go:171","msg":"trace[1112757157] transaction","detail":"{read_only:false; response_revision:4838; number_of_response:1; }","duration":"116.526162ms","start":"2026-04-17T00:40:26.780957Z","end":"2026-04-17T00:40:26.897484Z","steps":["trace[1112757157] 'process raft request' (duration: 116.151914ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:40:26.897659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.101032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:40:26.89774Z","caller":"traceutil/trace.go:171","msg":"trace[1198965784] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:4838; }","duration":"103.275086ms","start":"2026-04-17T00:40:26.794443Z","end":"2026-04-17T00:40:26.897718Z","steps":["trace[1198965784] 'agreement among raft nodes before linearized reading' (duration: 103.107652ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:40:31.708509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.538986ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T00:40:31.708686Z","caller":"traceutil/trace.go:171","msg":"trace[198330865] transaction","detail":"{read_only:false; response_revision:4939; number_of_response:1; }","duration":"131.270508ms","start":"2026-04-17T00:40:31.577379Z","end":"2026-04-17T00:40:31.70865Z","steps":["trace[198330865] 'process raft request' (duration: 24.311344ms)","trace[198330865] 'compare' (duration: 106.364251ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:40:31.709847Z","caller":"traceutil/trace.go:171","msg":"trace[1301082281] transaction","detail":"{read_only:false; response_revision:4940; number_of_response:1; }","duration":"120.446056ms","start":"2026-04-17T00:40:31.589368Z","end":"2026-04-17T00:40:31.709814Z","steps":["trace[1301082281] 'process raft request' (duration: 120.235841ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:40:46.923336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.930294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1990"} {"level":"info","ts":"2026-04-17T00:40:46.923456Z","caller":"traceutil/trace.go:171","msg":"trace[1339969847] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:5221; }","duration":"139.095227ms","start":"2026-04-17T00:40:46.784334Z","end":"2026-04-17T00:40:46.923429Z","steps":["trace[1339969847] 'range keys from in-memory index tree' (duration: 138.689029ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:40:47.103808Z","caller":"traceutil/trace.go:171","msg":"trace[233431988] transaction","detail":"{read_only:false; response_revision:5223; number_of_response:1; }","duration":"170.529984ms","start":"2026-04-17T00:40:46.933219Z","end":"2026-04-17T00:40:47.103749Z","steps":["trace[233431988] 'process raft request' (duration: 156.638865ms)","trace[233431988] 'compare' (duration: 13.500601ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:40:47.103808Z","caller":"traceutil/trace.go:171","msg":"trace[1107807676] linearizableReadLoop","detail":"{readStateIndex:5416; appliedIndex:5413; }","duration":"109.434058ms","start":"2026-04-17T00:40:46.994333Z","end":"2026-04-17T00:40:47.103767Z","steps":["trace[1107807676] 'read index received' (duration: 95.459367ms)","trace[1107807676] 'applied index is now lower than readState.Index' (duration: 13.972481ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:40:47.103903Z","caller":"traceutil/trace.go:171","msg":"trace[1645358356] transaction","detail":"{read_only:false; response_revision:5224; number_of_response:1; }","duration":"170.259298ms","start":"2026-04-17T00:40:46.933616Z","end":"2026-04-17T00:40:47.103876Z","steps":["trace[1645358356] 'process raft request' (duration: 169.972562ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:40:47.103897Z","caller":"traceutil/trace.go:171","msg":"trace[275489250] transaction","detail":"{read_only:false; response_revision:5225; number_of_response:1; }","duration":"119.72636ms","start":"2026-04-17T00:40:46.984141Z","end":"2026-04-17T00:40:47.103868Z","steps":["trace[275489250] 'process raft request' (duration: 119.540386ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:40:47.104149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.771835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus.18a6fe084defd8e4\" ","response":"range_response_count:1 size:745"} {"level":"info","ts":"2026-04-17T00:40:47.104219Z","caller":"traceutil/trace.go:171","msg":"trace[1946984162] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus.18a6fe084defd8e4; range_end:; response_count:1; response_revision:5225; }","duration":"109.915028ms","start":"2026-04-17T00:40:46.994283Z","end":"2026-04-17T00:40:47.104198Z","steps":["trace[1946984162] 'agreement among raft nodes before linearized reading' (duration: 109.630052ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:40:47.328277Z","caller":"traceutil/trace.go:171","msg":"trace[1439968994] transaction","detail":"{read_only:false; response_revision:5227; number_of_response:1; }","duration":"180.763274ms","start":"2026-04-17T00:40:47.147481Z","end":"2026-04-17T00:40:47.328244Z","steps":["trace[1439968994] 'process raft request' (duration: 167.554309ms)","trace[1439968994] 'compare' (duration: 13.060362ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:40:47.964501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.640552ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T00:40:47.964668Z","caller":"traceutil/trace.go:171","msg":"trace[1296737067] linearizableReadLoop","detail":"{readStateIndex:5435; appliedIndex:5434; }","duration":"135.624791ms","start":"2026-04-17T00:40:47.829015Z","end":"2026-04-17T00:40:47.964639Z","steps":["trace[1296737067] 'read index received' (duration: 18.58376ms)","trace[1296737067] 'applied index is now lower than readState.Index' (duration: 117.037801ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:40:47.964855Z","caller":"traceutil/trace.go:171","msg":"trace[2137865310] transaction","detail":"{read_only:false; response_revision:5244; number_of_response:1; }","duration":"136.172493ms","start":"2026-04-17T00:40:47.828638Z","end":"2026-04-17T00:40:47.964811Z","steps":["trace[2137865310] 'process raft request' (duration: 19.070021ms)","trace[2137865310] 'compare' (duration: 116.380047ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:40:47.965213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.171754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1451"} {"level":"info","ts":"2026-04-17T00:40:47.965392Z","caller":"traceutil/trace.go:171","msg":"trace[1293703863] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5244; }","duration":"136.42392ms","start":"2026-04-17T00:40:47.828943Z","end":"2026-04-17T00:40:47.965367Z","steps":["trace[1293703863] 'agreement among raft nodes before linearized reading' (duration: 135.953889ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:40:58.38546Z","caller":"traceutil/trace.go:171","msg":"trace[562787830] transaction","detail":"{read_only:false; response_revision:5410; number_of_response:1; }","duration":"160.883856ms","start":"2026-04-17T00:40:58.224541Z","end":"2026-04-17T00:40:58.385425Z","steps":["trace[562787830] 'process raft request' (duration: 112.751489ms)","trace[562787830] 'compare' (duration: 47.986334ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:41:55.577703Z","caller":"traceutil/trace.go:171","msg":"trace[1321152043] transaction","detail":"{read_only:false; response_revision:5906; number_of_response:1; }","duration":"107.719042ms","start":"2026-04-17T00:41:55.469944Z","end":"2026-04-17T00:41:55.577663Z","steps":["trace[1321152043] 'process raft request' (duration: 101.58027ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:03.141077Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2877} {"level":"info","ts":"2026-04-17T00:42:03.215441Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2877,"took":"72.40976ms","hash":1924457914,"current-db-size-bytes":57774080,"current-db-size":"58 MB","current-db-size-in-use-bytes":33148928,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-17T00:42:03.215496Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1924457914,"revision":2877,"compact-revision":-1} {"level":"info","ts":"2026-04-17T00:46:53.77897Z","caller":"traceutil/trace.go:171","msg":"trace[2122118607] linearizableReadLoop","detail":"{readStateIndex:8369; appliedIndex:8368; }","duration":"147.271777ms","start":"2026-04-17T00:46:53.631669Z","end":"2026-04-17T00:46:53.778941Z","steps":["trace[2122118607] 'read index received' (duration: 147.061802ms)","trace[2122118607] 'applied index is now lower than readState.Index' (duration: 208.655µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:46:53.779042Z","caller":"traceutil/trace.go:171","msg":"trace[209444264] transaction","detail":"{read_only:false; response_revision:8090; number_of_response:1; }","duration":"155.257409ms","start":"2026-04-17T00:46:53.623734Z","end":"2026-04-17T00:46:53.778992Z","steps":["trace[209444264] 'process raft request' (duration: 155.002924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:46:53.779328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.602465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-17T00:46:53.779469Z","caller":"traceutil/trace.go:171","msg":"trace[100480451] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8090; }","duration":"147.826719ms","start":"2026-04-17T00:46:53.631613Z","end":"2026-04-17T00:46:53.779439Z","steps":["trace[100480451] 'agreement among raft nodes before linearized reading' (duration: 147.44674ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:46:53.907019Z","caller":"traceutil/trace.go:171","msg":"trace[1486759940] linearizableReadLoop","detail":"{readStateIndex:8370; appliedIndex:8369; }","duration":"127.911099ms","start":"2026-04-17T00:46:53.77907Z","end":"2026-04-17T00:46:53.906981Z","steps":["trace[1486759940] 'read index received' (duration: 114.179223ms)","trace[1486759940] 'applied index is now lower than readState.Index' (duration: 13.729716ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:46:53.907038Z","caller":"traceutil/trace.go:171","msg":"trace[1433177216] transaction","detail":"{read_only:false; response_revision:8091; number_of_response:1; }","duration":"149.520335ms","start":"2026-04-17T00:46:53.757471Z","end":"2026-04-17T00:46:53.906991Z","steps":["trace[1433177216] 'process raft request' (duration: 135.784369ms)","trace[1433177216] 'compare' (duration: 13.269757ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:46:53.907332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.818777ms","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-17T00:46:53.90738Z","caller":"traceutil/trace.go:171","msg":"trace[2041979786] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8091; }","duration":"273.905639ms","start":"2026-04-17T00:46:53.633466Z","end":"2026-04-17T00:46:53.907372Z","steps":["trace[2041979786] 'agreement among raft nodes before linearized reading' (duration: 273.669724ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:46:53.907318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.758527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-17T00:46:53.907455Z","caller":"traceutil/trace.go:171","msg":"trace[1960762425] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8091; }","duration":"268.942471ms","start":"2026-04-17T00:46:53.638468Z","end":"2026-04-17T00:46:53.907411Z","steps":["trace[1960762425] 'agreement among raft nodes before linearized reading' (duration: 268.601694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:46:53.907478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.564755ms","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-17T00:46:53.907585Z","caller":"traceutil/trace.go:171","msg":"trace[983907509] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8091; }","duration":"269.706028ms","start":"2026-04-17T00:46:53.637855Z","end":"2026-04-17T00:46:53.907561Z","steps":["trace[983907509] 'agreement among raft nodes before linearized reading' (duration: 269.292529ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:46:53.907657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.909206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-17T00:46:53.907765Z","caller":"traceutil/trace.go:171","msg":"trace[140209042] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8091; }","duration":"139.08614ms","start":"2026-04-17T00:46:53.768645Z","end":"2026-04-17T00:46:53.907731Z","steps":["trace[140209042] 'agreement among raft nodes before linearized reading' (duration: 138.464447ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:46:53.911732Z","caller":"traceutil/trace.go:171","msg":"trace[1788556871] transaction","detail":"{read_only:false; response_revision:8092; number_of_response:1; }","duration":"127.102783ms","start":"2026-04-17T00:46:53.784604Z","end":"2026-04-17T00:46:53.911706Z","steps":["trace[1788556871] 'process raft request' (duration: 126.767275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:46:53.911837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.362185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-17T00:46:53.91195Z","caller":"traceutil/trace.go:171","msg":"trace[1241214082] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:8092; }","duration":"100.537059ms","start":"2026-04-17T00:46:53.811391Z","end":"2026-04-17T00:46:53.911928Z","steps":["trace[1241214082] 'agreement among raft nodes before linearized reading' (duration: 100.227903ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:46:54.638546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.808343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:46:54.638631Z","caller":"traceutil/trace.go:171","msg":"trace[960304012] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8097; }","duration":"105.928855ms","start":"2026-04-17T00:46:54.532683Z","end":"2026-04-17T00:46:54.638612Z","steps":["trace[960304012] 'range keys from in-memory index tree' (duration: 105.72998ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:46:54.969539Z","caller":"traceutil/trace.go:171","msg":"trace[1188994974] transaction","detail":"{read_only:false; response_revision:8099; number_of_response:1; }","duration":"249.817688ms","start":"2026-04-17T00:46:54.719678Z","end":"2026-04-17T00:46:54.969496Z","steps":["trace[1188994974] 'process raft request' (duration: 196.316265ms)","trace[1188994974] 'compare' (duration: 53.214837ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:47:03.149775Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5972} {"level":"info","ts":"2026-04-17T00:47:03.254488Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5972,"took":"102.336547ms","hash":866948710,"current-db-size-bytes":57774080,"current-db-size":"58 MB","current-db-size-in-use-bytes":22450176,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-17T00:47:03.254649Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":866948710,"revision":5972,"compact-revision":2877} {"level":"warn","ts":"2026-04-17T00:47:22.27664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.652596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:47:22.276744Z","caller":"traceutil/trace.go:171","msg":"trace[407634077] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:8294; }","duration":"199.84614ms","start":"2026-04-17T00:47:22.076878Z","end":"2026-04-17T00:47:22.276724Z","steps":["trace[407634077] 'count revisions from in-memory index tree' (duration: 199.522144ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:47:22.276865Z","caller":"traceutil/trace.go:171","msg":"trace[1378293418] linearizableReadLoop","detail":"{readStateIndex:8583; appliedIndex:8582; }","duration":"191.286716ms","start":"2026-04-17T00:47:22.085528Z","end":"2026-04-17T00:47:22.276815Z","steps":["trace[1378293418] 'read index received' (duration: 178.073592ms)","trace[1378293418] 'applied index is now lower than readState.Index' (duration: 13.210794ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:47:22.277029Z","caller":"traceutil/trace.go:171","msg":"trace[998436313] transaction","detail":"{read_only:false; response_revision:8295; number_of_response:1; }","duration":"194.74203ms","start":"2026-04-17T00:47:22.082278Z","end":"2026-04-17T00:47:22.27702Z","steps":["trace[998436313] 'process raft request' (duration: 181.451004ms)","trace[998436313] 'compare' (duration: 12.761035ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:47:22.277233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.280415ms","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":"warn","ts":"2026-04-17T00:47:22.277239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.677074ms","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-17T00:47:22.277255Z","caller":"traceutil/trace.go:171","msg":"trace[946519617] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8295; }","duration":"165.312365ms","start":"2026-04-17T00:47:22.111937Z","end":"2026-04-17T00:47:22.277249Z","steps":["trace[946519617] 'agreement among raft nodes before linearized reading' (duration: 165.236074ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:47:22.27729Z","caller":"traceutil/trace.go:171","msg":"trace[2104370788] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8295; }","duration":"191.95618ms","start":"2026-04-17T00:47:22.085312Z","end":"2026-04-17T00:47:22.277268Z","steps":["trace[2104370788] 'agreement among raft nodes before linearized reading' (duration: 191.725875ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:47:22.277252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.924824ms","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-17T00:47:22.277565Z","caller":"traceutil/trace.go:171","msg":"trace[1131404547] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8295; }","duration":"188.222111ms","start":"2026-04-17T00:47:22.089297Z","end":"2026-04-17T00:47:22.277519Z","steps":["trace[1131404547] 'agreement among raft nodes before linearized reading' (duration: 187.800581ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:47:22.277805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.747807ms","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-17T00:47:22.27807Z","caller":"traceutil/trace.go:171","msg":"trace[1067677610] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8295; }","duration":"180.481623ms","start":"2026-04-17T00:47:22.09757Z","end":"2026-04-17T00:47:22.278052Z","steps":["trace[1067677610] 'agreement among raft nodes before linearized reading' (duration: 179.616854ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:47:22.278975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.395673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-17T00:47:22.279126Z","caller":"traceutil/trace.go:171","msg":"trace[2128520112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8295; }","duration":"169.577778ms","start":"2026-04-17T00:47:22.109523Z","end":"2026-04-17T00:47:22.279101Z","steps":["trace[2128520112] 'agreement among raft nodes before linearized reading' (duration: 167.648966ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:47:22.441141Z","caller":"traceutil/trace.go:171","msg":"trace[127453051] transaction","detail":"{read_only:false; response_revision:8299; number_of_response:1; }","duration":"156.329032ms","start":"2026-04-17T00:47:22.284775Z","end":"2026-04-17T00:47:22.441104Z","steps":["trace[127453051] 'process raft request' (duration: 156.249921ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:47:22.441214Z","caller":"traceutil/trace.go:171","msg":"trace[1271381265] transaction","detail":"{read_only:false; response_revision:8298; number_of_response:1; }","duration":"156.766942ms","start":"2026-04-17T00:47:22.2844Z","end":"2026-04-17T00:47:22.441167Z","steps":["trace[1271381265] 'process raft request' (duration: 156.581748ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:47:22.441151Z","caller":"traceutil/trace.go:171","msg":"trace[1527577432] transaction","detail":"{read_only:false; response_revision:8297; number_of_response:1; }","duration":"156.851903ms","start":"2026-04-17T00:47:22.284246Z","end":"2026-04-17T00:47:22.441098Z","steps":["trace[1527577432] 'process raft request' (duration: 156.552017ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:47:22.441357Z","caller":"traceutil/trace.go:171","msg":"trace[1243251152] transaction","detail":"{read_only:false; response_revision:8300; number_of_response:1; }","duration":"154.205636ms","start":"2026-04-17T00:47:22.287139Z","end":"2026-04-17T00:47:22.441344Z","steps":["trace[1243251152] 'process raft request' (duration: 153.92341ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:47:36.794181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.83325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-17T00:47:36.794308Z","caller":"traceutil/trace.go:171","msg":"trace[446527778] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8413; }","duration":"391.033096ms","start":"2026-04-17T00:47:36.403245Z","end":"2026-04-17T00:47:36.794278Z","steps":["trace[446527778] 'range keys from in-memory index tree' (duration: 390.582545ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:47:36.794358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:47:36.403211Z","time spent":"391.136148ms","remote":"127.0.0.1:58102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-17T00:47:36.795016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.06018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-wbp7h\" ","response":"range_response_count:1 size:4645"} {"level":"info","ts":"2026-04-17T00:47:36.79512Z","caller":"traceutil/trace.go:171","msg":"trace[1030321866] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-wbp7h; range_end:; response_count:1; response_revision:8413; }","duration":"362.199313ms","start":"2026-04-17T00:47:36.432897Z","end":"2026-04-17T00:47:36.795097Z","steps":["trace[1030321866] 'range keys from in-memory index tree' (duration: 361.899017ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:47:36.795169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:47:36.432883Z","time spent":"362.276735ms","remote":"127.0.0.1:58016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":4668,"request content":"key:\"/registry/pods/openstack/rook-ceph-detect-version-wbp7h\" "} {"level":"warn","ts":"2026-04-17T00:47:36.795762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.694552ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-17T00:47:36.795843Z","caller":"traceutil/trace.go:171","msg":"trace[1466554296] linearizableReadLoop","detail":"{readStateIndex:8708; appliedIndex:8707; }","duration":"261.702115ms","start":"2026-04-17T00:47:36.534127Z","end":"2026-04-17T00:47:36.79583Z","steps":["trace[1466554296] 'read index received' (duration: 58.729717ms)","trace[1466554296] 'applied index is now lower than readState.Index' (duration: 202.971118ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:47:36.795918Z","caller":"traceutil/trace.go:171","msg":"trace[1186214264] transaction","detail":"{read_only:false; response_revision:8414; number_of_response:1; }","duration":"362.690804ms","start":"2026-04-17T00:47:36.433215Z","end":"2026-04-17T00:47:36.795905Z","steps":["trace[1186214264] 'process raft request' (duration: 159.780397ms)","trace[1186214264] 'compare' (duration: 201.66253ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:47:36.795971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:47:36.433192Z","time spent":"362.755665ms","remote":"127.0.0.1:57896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":746,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T00:47:36.796065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.93553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:47:36.796113Z","caller":"traceutil/trace.go:171","msg":"trace[163126034] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8414; }","duration":"262.029242ms","start":"2026-04-17T00:47:36.53407Z","end":"2026-04-17T00:47:36.796099Z","steps":["trace[163126034] 'agreement among raft nodes before linearized reading' (duration: 261.920789ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:47:36.825354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.064378ms","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-17T00:47:36.825473Z","caller":"traceutil/trace.go:171","msg":"trace[1591685870] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8415; }","duration":"118.253432ms","start":"2026-04-17T00:47:36.707195Z","end":"2026-04-17T00:47:36.825448Z","steps":["trace[1591685870] 'agreement among raft nodes before linearized reading' (duration: 117.918075ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:47:36.825454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.948849ms","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-17T00:47:36.82558Z","caller":"traceutil/trace.go:171","msg":"trace[202400797] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8415; }","duration":"274.137573ms","start":"2026-04-17T00:47:36.551401Z","end":"2026-04-17T00:47:36.825539Z","steps":["trace[202400797] 'agreement among raft nodes before linearized reading' (duration: 273.780555ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:47:36.825832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.644743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-17T00:47:36.825869Z","caller":"traceutil/trace.go:171","msg":"trace[639959069] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8415; }","duration":"273.694814ms","start":"2026-04-17T00:47:36.552165Z","end":"2026-04-17T00:47:36.82586Z","steps":["trace[639959069] 'agreement among raft nodes before linearized reading' (duration: 273.597982ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:47:36.825853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.432689ms","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-17T00:47:36.825972Z","caller":"traceutil/trace.go:171","msg":"trace[1023011989] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8415; }","duration":"274.616384ms","start":"2026-04-17T00:47:36.551326Z","end":"2026-04-17T00:47:36.825942Z","steps":["trace[1023011989] 'agreement among raft nodes before linearized reading' (duration: 274.237065ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:47:36.826121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.199298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-17T00:47:36.826227Z","caller":"traceutil/trace.go:171","msg":"trace[1450822814] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8415; }","duration":"289.383172ms","start":"2026-04-17T00:47:36.536821Z","end":"2026-04-17T00:47:36.826204Z","steps":["trace[1450822814] 'agreement among raft nodes before linearized reading' (duration: 289.027265ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:47:37.882855Z","caller":"traceutil/trace.go:171","msg":"trace[761922999] transaction","detail":"{read_only:false; response_revision:8424; number_of_response:1; }","duration":"228.204332ms","start":"2026-04-17T00:47:37.654613Z","end":"2026-04-17T00:47:37.882817Z","steps":["trace[761922999] 'process raft request' (duration: 227.919796ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:48:26.975915Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002419.wal"} {"level":"info","ts":"2026-04-17T00:50:00.992636Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39582465ceaa2f67","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-17T00:50:00.999152Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-17T00:50:00.999336Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-17T00:52:03.157247Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8149} {"level":"info","ts":"2026-04-17T00:52:03.227682Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8149,"took":"67.47216ms","hash":2360426749,"current-db-size-bytes":57774080,"current-db-size":"58 MB","current-db-size-in-use-bytes":29343744,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-17T00:52:03.22775Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2360426749,"revision":8149,"compact-revision":5972} {"level":"info","ts":"2026-04-17T00:57:03.162761Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10572} {"level":"info","ts":"2026-04-17T00:57:03.245883Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10572,"took":"80.350276ms","hash":2401170864,"current-db-size-bytes":57774080,"current-db-size":"58 MB","current-db-size-in-use-bytes":19898368,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-17T00:57:03.245946Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2401170864,"revision":10572,"compact-revision":8149} {"level":"info","ts":"2026-04-17T00:57:47.595479Z","caller":"traceutil/trace.go:171","msg":"trace[1448754450] transaction","detail":"{read_only:false; response_revision:12347; number_of_response:1; }","duration":"182.808206ms","start":"2026-04-17T00:57:47.412646Z","end":"2026-04-17T00:57:47.595454Z","steps":["trace[1448754450] 'process raft request' (duration: 182.457099ms)"],"step_count":1}