{"level":"warn","ts":"2026-04-07T12:49:52.811432Z","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-07T12:49:52.811538Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.153: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.153:2380","--initial-cluster=instance=https://199.204.45.153:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.153:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.153: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-07T12:49:52.811629Z","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-07T12:49:52.811645Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.153:2380"]} {"level":"info","ts":"2026-04-07T12:49:52.811666Z","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-07T12:49:52.812532Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"]} {"level":"info","ts":"2026-04-07T12:49:52.812626Z","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.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.153: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-07T12:49:52.816069Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.1738ms"} {"level":"info","ts":"2026-04-07T12:49:52.823347Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"355195d5aae85944","cluster-id":"e424441517bc0b32"} {"level":"info","ts":"2026-04-07T12:49:52.823437Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T12:49:52.823477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 0"} {"level":"info","ts":"2026-04-07T12:49:52.823496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 355195d5aae85944 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T12:49:52.823504Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 1"} {"level":"info","ts":"2026-04-07T12:49:52.823546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"} {"level":"warn","ts":"2026-04-07T12:49:52.832676Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T12:49:52.838547Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T12:49:52.839673Z","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-07T12:49:52.841632Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"355195d5aae85944","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T12:49:52.841812Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"355195d5aae85944","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T12:49:52.841967Z","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-07T12:49:52.842062Z","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-07T12:49:52.842078Z","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-07T12:49:52.845522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"} {"level":"info","ts":"2026-04-07T12:49:52.845707Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","added-peer-id":"355195d5aae85944","added-peer-peer-urls":["https://199.204.45.153:2380"]} {"level":"info","ts":"2026-04-07T12:49:52.848842Z","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-07T12:49:52.848956Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.153:2380"} {"level":"info","ts":"2026-04-07T12:49:52.849016Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.153:2380"} {"level":"info","ts":"2026-04-07T12:49:52.849226Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"355195d5aae85944","initial-advertise-peer-urls":["https://199.204.45.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T12:49:52.849294Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T12:49:53.623791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T12:49:53.623845Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T12:49:53.623901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgPreVoteResp from 355195d5aae85944 at term 1"} {"level":"info","ts":"2026-04-07T12:49:53.623927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became candidate at term 2"} {"level":"info","ts":"2026-04-07T12:49:53.623934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgVoteResp from 355195d5aae85944 at term 2"} {"level":"info","ts":"2026-04-07T12:49:53.623945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became leader at term 2"} {"level":"info","ts":"2026-04-07T12:49:53.623953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 355195d5aae85944 elected leader 355195d5aae85944 at term 2"} {"level":"info","ts":"2026-04-07T12:49:53.624951Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T12:49:53.627548Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T12:49:53.627546Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"355195d5aae85944","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.153:2379]}","request-path":"/0/members/355195d5aae85944/attributes","cluster-id":"e424441517bc0b32","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T12:49:53.627613Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T12:49:53.627915Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T12:49:53.62796Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T12:49:53.628687Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T12:49:53.62876Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T12:49:53.628781Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T12:49:53.629622Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.153:2379"} {"level":"info","ts":"2026-04-07T12:49:53.630933Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T12:50:21.952605Z","caller":"traceutil/trace.go:171","msg":"trace[1301267106] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"100.31314ms","start":"2026-04-07T12:50:21.852271Z","end":"2026-04-07T12:50:21.952584Z","steps":["trace[1301267106] 'compare' (duration: 89.489897ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:50:21.952738Z","caller":"traceutil/trace.go:171","msg":"trace[1645932064] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"100.412841ms","start":"2026-04-07T12:50:21.852314Z","end":"2026-04-07T12:50:21.952727Z","steps":["trace[1645932064] 'process raft request' (duration: 100.000247ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:50:28.512048Z","caller":"traceutil/trace.go:171","msg":"trace[26330310] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"183.613205ms","start":"2026-04-07T12:50:28.328413Z","end":"2026-04-07T12:50:28.512026Z","steps":["trace[26330310] 'read index received' (duration: 183.01468ms)","trace[26330310] 'applied index is now lower than readState.Index' (duration: 597.765µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:50:28.51219Z","caller":"traceutil/trace.go:171","msg":"trace[1885528511] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"213.004136ms","start":"2026-04-07T12:50:28.299149Z","end":"2026-04-07T12:50:28.512154Z","steps":["trace[1885528511] 'process raft request' (duration: 212.428051ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:50:28.512246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.819717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-gz7rx\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-07T12:50:28.512308Z","caller":"traceutil/trace.go:171","msg":"trace[1957317654] range","detail":"{range_begin:/registry/pods/kube-system/cilium-gz7rx; range_end:; response_count:1; response_revision:581; }","duration":"183.922738ms","start":"2026-04-07T12:50:28.328367Z","end":"2026-04-07T12:50:28.51229Z","steps":["trace[1957317654] 'agreement among raft nodes before linearized reading' (duration: 183.784417ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:50:28.783702Z","caller":"traceutil/trace.go:171","msg":"trace[379512968] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"257.279001ms","start":"2026-04-07T12:50:28.526378Z","end":"2026-04-07T12:50:28.783657Z","steps":["trace[379512968] 'process raft request' (duration: 190.610837ms)","trace[379512968] 'compare' (duration: 66.382171ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:50:28.784018Z","caller":"traceutil/trace.go:171","msg":"trace[498983145] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"216.599858ms","start":"2026-04-07T12:50:28.567386Z","end":"2026-04-07T12:50:28.783985Z","steps":["trace[498983145] 'process raft request' (duration: 216.183105ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:50:29.243763Z","caller":"traceutil/trace.go:171","msg":"trace[1832807610] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"435.816727ms","start":"2026-04-07T12:50:28.807908Z","end":"2026-04-07T12:50:29.243724Z","steps":["trace[1832807610] 'process raft request' (duration: 391.153673ms)","trace[1832807610] 'compare' (duration: 44.427982ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T12:50:29.244429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T12:50:28.807897Z","time spent":"435.987848ms","remote":"127.0.0.1:52908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T12:50:29.270765Z","caller":"traceutil/trace.go:171","msg":"trace[1698376384] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"228.589664ms","start":"2026-04-07T12:50:29.042145Z","end":"2026-04-07T12:50:29.270735Z","steps":["trace[1698376384] 'process raft request' (duration: 228.291431ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:51:12.785659Z","caller":"traceutil/trace.go:171","msg":"trace[118441424] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"115.339842ms","start":"2026-04-07T12:51:12.670286Z","end":"2026-04-07T12:51:12.785626Z","steps":["trace[118441424] 'process raft request' (duration: 115.15815ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:51:58.163664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.836399ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T12:51:58.163781Z","caller":"traceutil/trace.go:171","msg":"trace[1922312241] linearizableReadLoop","detail":"{readStateIndex:1877; appliedIndex:1876; }","duration":"373.635432ms","start":"2026-04-07T12:51:57.790128Z","end":"2026-04-07T12:51:58.163763Z","steps":["trace[1922312241] 'read index received' (duration: 27.841µs)","trace[1922312241] 'applied index is now lower than readState.Index' (duration: 373.606161ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:51:58.163862Z","caller":"traceutil/trace.go:171","msg":"trace[873401454] transaction","detail":"{read_only:false; response_revision:1808; number_of_response:1; }","duration":"409.247138ms","start":"2026-04-07T12:51:57.754577Z","end":"2026-04-07T12:51:58.163824Z","steps":["trace[873401454] 'process raft request' (duration: 16.864196ms)","trace[873401454] 'compare' (duration: 391.684956ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T12:51:58.163903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.947774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-07T12:51:58.163957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.813666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f1ef5ef4-6d6c-447c-8631-60735ba07023\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-07T12:51:58.164015Z","caller":"traceutil/trace.go:171","msg":"trace[1883812939] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f1ef5ef4-6d6c-447c-8631-60735ba07023; range_end:; response_count:1; response_revision:1808; }","duration":"373.907938ms","start":"2026-04-07T12:51:57.790094Z","end":"2026-04-07T12:51:58.164002Z","steps":["trace[1883812939] 'agreement among raft nodes before linearized reading' (duration: 373.732284ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:51:58.164022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T12:51:57.754558Z","time spent":"409.37631ms","remote":"127.0.0.1:52990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T12:51:58.164054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T12:51:57.790081Z","time spent":"373.967401ms","remote":"127.0.0.1:52908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f1ef5ef4-6d6c-447c-8631-60735ba07023\" "} {"level":"warn","ts":"2026-04-07T12:51:58.164088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.293851ms","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":"warn","ts":"2026-04-07T12:51:58.164063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.570849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-07T12:51:58.16413Z","caller":"traceutil/trace.go:171","msg":"trace[795492079] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1808; }","duration":"241.357953ms","start":"2026-04-07T12:51:57.92276Z","end":"2026-04-07T12:51:58.164118Z","steps":["trace[795492079] 'agreement among raft nodes before linearized reading' (duration: 241.22013ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:51:58.164154Z","caller":"traceutil/trace.go:171","msg":"trace[1935996245] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1808; }","duration":"140.701642ms","start":"2026-04-07T12:51:58.023428Z","end":"2026-04-07T12:51:58.16413Z","steps":["trace[1935996245] 'agreement among raft nodes before linearized reading' (duration: 140.498677ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:51:58.164358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.440761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-07T12:51:58.164409Z","caller":"traceutil/trace.go:171","msg":"trace[1858999210] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1808; }","duration":"264.513813ms","start":"2026-04-07T12:51:57.899883Z","end":"2026-04-07T12:51:58.164397Z","steps":["trace[1858999210] 'agreement among raft nodes before linearized reading' (duration: 264.342369ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:51:58.163937Z","caller":"traceutil/trace.go:171","msg":"trace[1589031122] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1808; }","duration":"317.011625ms","start":"2026-04-07T12:51:57.846916Z","end":"2026-04-07T12:51:58.163927Z","steps":["trace[1589031122] 'agreement among raft nodes before linearized reading' (duration: 316.939673ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:51:58.165457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T12:51:57.846896Z","time spent":"318.54067ms","remote":"127.0.0.1:53156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-04-07T12:51:58.364062Z","caller":"traceutil/trace.go:171","msg":"trace[242461166] transaction","detail":"{read_only:false; response_revision:1811; number_of_response:1; }","duration":"192.503226ms","start":"2026-04-07T12:51:58.171535Z","end":"2026-04-07T12:51:58.364038Z","steps":["trace[242461166] 'process raft request' (duration: 192.440435ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:51:58.364093Z","caller":"traceutil/trace.go:171","msg":"trace[774610337] transaction","detail":"{read_only:false; response_revision:1810; number_of_response:1; }","duration":"195.989976ms","start":"2026-04-07T12:51:58.168069Z","end":"2026-04-07T12:51:58.364059Z","steps":["trace[774610337] 'process raft request' (duration: 104.718736ms)","trace[774610337] 'compare' (duration: 91.053365ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:52:13.085028Z","caller":"traceutil/trace.go:171","msg":"trace[1231385842] transaction","detail":"{read_only:false; response_revision:1927; number_of_response:1; }","duration":"143.164183ms","start":"2026-04-07T12:52:12.941841Z","end":"2026-04-07T12:52:13.085005Z","steps":["trace[1231385842] 'process raft request' (duration: 142.99496ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:52:13.086438Z","caller":"traceutil/trace.go:171","msg":"trace[1393437000] transaction","detail":"{read_only:false; response_revision:1928; number_of_response:1; }","duration":"141.926279ms","start":"2026-04-07T12:52:12.944499Z","end":"2026-04-07T12:52:13.086425Z","steps":["trace[1393437000] 'process raft request' (duration: 141.695354ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:52:47.072942Z","caller":"traceutil/trace.go:171","msg":"trace[2143468327] linearizableReadLoop","detail":"{readStateIndex:2202; appliedIndex:2201; }","duration":"152.456431ms","start":"2026-04-07T12:52:46.920461Z","end":"2026-04-07T12:52:47.072917Z","steps":["trace[2143468327] 'read index received' (duration: 152.252718ms)","trace[2143468327] 'applied index is now lower than readState.Index' (duration: 200.903µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:52:47.073109Z","caller":"traceutil/trace.go:171","msg":"trace[401450773] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"217.879609ms","start":"2026-04-07T12:52:46.8552Z","end":"2026-04-07T12:52:47.073079Z","steps":["trace[401450773] 'process raft request' (duration: 217.567544ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:52:47.073321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.847637ms","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-07T12:52:47.073372Z","caller":"traceutil/trace.go:171","msg":"trace[391494809] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2122; }","duration":"152.940169ms","start":"2026-04-07T12:52:46.920417Z","end":"2026-04-07T12:52:47.073357Z","steps":["trace[391494809] 'agreement among raft nodes before linearized reading' (duration: 152.610534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:52:47.26482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.837609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T12:52:47.264963Z","caller":"traceutil/trace.go:171","msg":"trace[483953698] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2122; }","duration":"164.013423ms","start":"2026-04-07T12:52:47.100932Z","end":"2026-04-07T12:52:47.264946Z","steps":["trace[483953698] 'range keys from in-memory index tree' (duration: 163.735208ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:52:47.373974Z","caller":"traceutil/trace.go:171","msg":"trace[2106769497] transaction","detail":"{read_only:false; response_revision:2124; number_of_response:1; }","duration":"104.330061ms","start":"2026-04-07T12:52:47.269624Z","end":"2026-04-07T12:52:47.373954Z","steps":["trace[2106769497] 'process raft request' (duration: 99.201012ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:52:47.374166Z","caller":"traceutil/trace.go:171","msg":"trace[215218101] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"104.468192ms","start":"2026-04-07T12:52:47.269678Z","end":"2026-04-07T12:52:47.374147Z","steps":["trace[215218101] 'process raft request' (duration: 104.242629ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:54:08.585527Z","caller":"traceutil/trace.go:171","msg":"trace[1185989620] linearizableReadLoop","detail":"{readStateIndex:2769; appliedIndex:2768; }","duration":"225.709081ms","start":"2026-04-07T12:54:08.3598Z","end":"2026-04-07T12:54:08.585509Z","steps":["trace[1185989620] 'read index received' (duration: 225.53131ms)","trace[1185989620] 'applied index is now lower than readState.Index' (duration: 177.181µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:54:08.585569Z","caller":"traceutil/trace.go:171","msg":"trace[971336555] transaction","detail":"{read_only:false; response_revision:2670; number_of_response:1; }","duration":"227.565802ms","start":"2026-04-07T12:54:08.357984Z","end":"2026-04-07T12:54:08.58555Z","steps":["trace[971336555] 'process raft request' (duration: 227.41022ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:54:08.585788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.953734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-07T12:54:08.585878Z","caller":"traceutil/trace.go:171","msg":"trace[1079466166] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2670; }","duration":"226.087405ms","start":"2026-04-07T12:54:08.359773Z","end":"2026-04-07T12:54:08.58586Z","steps":["trace[1079466166] 'agreement among raft nodes before linearized reading' (duration: 225.822502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:54:08.586262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.17421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T12:54:08.586365Z","caller":"traceutil/trace.go:171","msg":"trace[1833258226] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:2670; }","duration":"134.869816ms","start":"2026-04-07T12:54:08.451484Z","end":"2026-04-07T12:54:08.586354Z","steps":["trace[1833258226] 'agreement among raft nodes before linearized reading' (duration: 134.177199ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:54:13.974281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.598006ms","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-07T12:54:13.974435Z","caller":"traceutil/trace.go:171","msg":"trace[211605752] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2697; }","duration":"172.810199ms","start":"2026-04-07T12:54:13.801612Z","end":"2026-04-07T12:54:13.974422Z","steps":["trace[211605752] 'range keys from in-memory index tree' (duration: 172.437644ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:54:13.974704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.223713ms","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-07T12:54:13.974775Z","caller":"traceutil/trace.go:171","msg":"trace[594964955] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2697; }","duration":"173.341105ms","start":"2026-04-07T12:54:13.801421Z","end":"2026-04-07T12:54:13.974762Z","steps":["trace[594964955] 'range keys from in-memory index tree' (duration: 173.077001ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:57:54.184315Z","caller":"traceutil/trace.go:171","msg":"trace[455931138] linearizableReadLoop","detail":"{readStateIndex:4617; appliedIndex:4615; }","duration":"110.344359ms","start":"2026-04-07T12:57:54.07395Z","end":"2026-04-07T12:57:54.184295Z","steps":["trace[455931138] 'read index received' (duration: 87.371285ms)","trace[455931138] 'applied index is now lower than readState.Index' (duration: 22.972124ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:57:54.184342Z","caller":"traceutil/trace.go:171","msg":"trace[1947716142] transaction","detail":"{read_only:false; response_revision:4444; number_of_response:1; }","duration":"113.588254ms","start":"2026-04-07T12:57:54.070701Z","end":"2026-04-07T12:57:54.184289Z","steps":["trace[1947716142] 'process raft request' (duration: 113.409191ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:57:54.184905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.93064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4737"} {"level":"info","ts":"2026-04-07T12:57:54.184943Z","caller":"traceutil/trace.go:171","msg":"trace[1423076921] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4445; }","duration":"111.004222ms","start":"2026-04-07T12:57:54.073929Z","end":"2026-04-07T12:57:54.184933Z","steps":["trace[1423076921] 'agreement among raft nodes before linearized reading' (duration: 110.814748ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:57:54.185266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.316407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"} {"level":"info","ts":"2026-04-07T12:57:54.185322Z","caller":"traceutil/trace.go:171","msg":"trace[155241905] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4445; }","duration":"101.40119ms","start":"2026-04-07T12:57:54.083899Z","end":"2026-04-07T12:57:54.185301Z","steps":["trace[155241905] 'agreement among raft nodes before linearized reading' (duration: 101.154755ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:57:54.185669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.646825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:7 size:60699"} {"level":"info","ts":"2026-04-07T12:57:54.185707Z","caller":"traceutil/trace.go:171","msg":"trace[1705822904] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:7; response_revision:4445; }","duration":"101.695605ms","start":"2026-04-07T12:57:54.084001Z","end":"2026-04-07T12:57:54.185697Z","steps":["trace[1705822904] 'agreement among raft nodes before linearized reading' (duration: 101.478281ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:58:00.895813Z","caller":"traceutil/trace.go:171","msg":"trace[1205378045] transaction","detail":"{read_only:false; response_revision:4581; number_of_response:1; }","duration":"112.300048ms","start":"2026-04-07T12:58:00.783483Z","end":"2026-04-07T12:58:00.895783Z","steps":["trace[1205378045] 'process raft request' (duration: 112.112774ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:58:00.906975Z","caller":"traceutil/trace.go:171","msg":"trace[908455700] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4582; }","duration":"123.402718ms","start":"2026-04-07T12:58:00.78356Z","end":"2026-04-07T12:58:00.906962Z","steps":["trace[908455700] 'process raft request' (duration: 123.204354ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:58:00.906939Z","caller":"traceutil/trace.go:171","msg":"trace[371928178] linearizableReadLoop","detail":"{readStateIndex:4759; appliedIndex:4757; }","duration":"123.219804ms","start":"2026-04-07T12:58:00.783695Z","end":"2026-04-07T12:58:00.906915Z","steps":["trace[371928178] 'read index received' (duration: 111.348139ms)","trace[371928178] 'applied index is now lower than readState.Index' (duration: 11.870455ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T12:58:00.907214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.50715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-04-07T12:58:00.907263Z","caller":"traceutil/trace.go:171","msg":"trace[2049558219] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4582; }","duration":"123.615852ms","start":"2026-04-07T12:58:00.783634Z","end":"2026-04-07T12:58:00.90725Z","steps":["trace[2049558219] 'agreement among raft nodes before linearized reading' (duration: 123.424929ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:58:07.636473Z","caller":"traceutil/trace.go:171","msg":"trace[568058913] transaction","detail":"{read_only:false; response_revision:4689; number_of_response:1; }","duration":"301.425528ms","start":"2026-04-07T12:58:07.335014Z","end":"2026-04-07T12:58:07.636439Z","steps":["trace[568058913] 'process raft request' (duration: 204.81165ms)","trace[568058913] 'compare' (duration: 96.268071ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T12:58:07.636624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T12:58:07.334991Z","time spent":"301.55079ms","remote":"127.0.0.1:46026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7567,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T12:58:07.695037Z","caller":"traceutil/trace.go:171","msg":"trace[1231150368] transaction","detail":"{read_only:false; response_revision:4690; number_of_response:1; }","duration":"260.628506ms","start":"2026-04-07T12:58:07.434368Z","end":"2026-04-07T12:58:07.694997Z","steps":["trace[1231150368] 'process raft request' (duration: 260.390021ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:58:07.708794Z","caller":"traceutil/trace.go:171","msg":"trace[936708707] transaction","detail":"{read_only:false; response_revision:4691; number_of_response:1; }","duration":"140.421589ms","start":"2026-04-07T12:58:07.568335Z","end":"2026-04-07T12:58:07.708757Z","steps":["trace[936708707] 'process raft request' (duration: 140.198545ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:58:07.709122Z","caller":"traceutil/trace.go:171","msg":"trace[2147355523] transaction","detail":"{read_only:false; response_revision:4692; number_of_response:1; }","duration":"112.649879ms","start":"2026-04-07T12:58:07.596461Z","end":"2026-04-07T12:58:07.709111Z","steps":["trace[2147355523] 'process raft request' (duration: 112.241801ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:58:07.709305Z","caller":"traceutil/trace.go:171","msg":"trace[1570652635] linearizableReadLoop","detail":"{readStateIndex:4870; appliedIndex:4868; }","duration":"135.441273ms","start":"2026-04-07T12:58:07.573853Z","end":"2026-04-07T12:58:07.709294Z","steps":["trace[1570652635] 'read index received' (duration: 120.87111ms)","trace[1570652635] 'applied index is now lower than readState.Index' (duration: 14.568453ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T12:58:07.711195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.293179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2193165"} {"level":"info","ts":"2026-04-07T12:58:07.711329Z","caller":"traceutil/trace.go:171","msg":"trace[507147610] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4693; }","duration":"137.480872ms","start":"2026-04-07T12:58:07.573815Z","end":"2026-04-07T12:58:07.711296Z","steps":["trace[507147610] 'agreement among raft nodes before linearized reading' (duration: 135.563544ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:58:08.105519Z","caller":"traceutil/trace.go:171","msg":"trace[1824950447] linearizableReadLoop","detail":"{readStateIndex:4880; appliedIndex:4878; }","duration":"222.631272ms","start":"2026-04-07T12:58:07.882856Z","end":"2026-04-07T12:58:08.105487Z","steps":["trace[1824950447] 'read index received' (duration: 221.845656ms)","trace[1824950447] 'applied index is now lower than readState.Index' (duration: 784.046µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T12:58:08.105799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.909597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T12:58:08.105844Z","caller":"traceutil/trace.go:171","msg":"trace[1594102871] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1; range_end:; response_count:0; response_revision:4701; }","duration":"222.990679ms","start":"2026-04-07T12:58:07.882841Z","end":"2026-04-07T12:58:08.105831Z","steps":["trace[1594102871] 'agreement among raft nodes before linearized reading' (duration: 222.799295ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:58:08.105869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.318959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7b5fc1c2-9d9f-4a1b-97b8-eb70b151a121\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-07T12:58:08.105919Z","caller":"traceutil/trace.go:171","msg":"trace[827056985] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7b5fc1c2-9d9f-4a1b-97b8-eb70b151a121; range_end:; response_count:1; response_revision:4701; }","duration":"110.39013ms","start":"2026-04-07T12:58:07.995519Z","end":"2026-04-07T12:58:08.105909Z","steps":["trace[827056985] 'agreement among raft nodes before linearized reading' (duration: 110.176576ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:58:08.106142Z","caller":"traceutil/trace.go:171","msg":"trace[1313011068] transaction","detail":"{read_only:false; response_revision:4700; number_of_response:1; }","duration":"226.528217ms","start":"2026-04-07T12:58:07.879588Z","end":"2026-04-07T12:58:08.106116Z","steps":["trace[1313011068] 'process raft request' (duration: 225.580849ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:58:08.105633Z","caller":"traceutil/trace.go:171","msg":"trace[1077503844] transaction","detail":"{read_only:false; response_revision:4701; number_of_response:1; }","duration":"225.907145ms","start":"2026-04-07T12:58:07.879673Z","end":"2026-04-07T12:58:08.10558Z","steps":["trace[1077503844] 'process raft request' (duration: 225.772562ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:58:21.213632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.103834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T12:58:21.213735Z","caller":"traceutil/trace.go:171","msg":"trace[1311017801] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:4866; }","duration":"159.234736ms","start":"2026-04-07T12:58:21.054482Z","end":"2026-04-07T12:58:21.213716Z","steps":["trace[1311017801] 'count revisions from in-memory index tree' (duration: 158.994212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:58:21.214285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.37327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T12:58:21.214399Z","caller":"traceutil/trace.go:171","msg":"trace[558399261] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4866; }","duration":"112.541804ms","start":"2026-04-07T12:58:21.101846Z","end":"2026-04-07T12:58:21.214387Z","steps":["trace[558399261] 'range keys from in-memory index tree' (duration: 112.267398ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:58:21.354943Z","caller":"traceutil/trace.go:171","msg":"trace[1668569287] transaction","detail":"{read_only:false; response_revision:4867; number_of_response:1; }","duration":"128.965341ms","start":"2026-04-07T12:58:21.225943Z","end":"2026-04-07T12:58:21.354908Z","steps":["trace[1668569287] 'process raft request' (duration: 128.720686ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:59:53.657031Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2908} {"level":"info","ts":"2026-04-07T12:59:53.761996Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2908,"took":"103.131889ms","hash":3377846423,"current-db-size-bytes":54214656,"current-db-size":"54 MB","current-db-size-in-use-bytes":29315072,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-07T12:59:53.762218Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3377846423,"revision":2908,"compact-revision":-1} {"level":"info","ts":"2026-04-07T13:04:53.662932Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5628} {"level":"info","ts":"2026-04-07T13:04:53.740981Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5628,"took":"76.155885ms","hash":1916965358,"current-db-size-bytes":54214656,"current-db-size":"54 MB","current-db-size-in-use-bytes":18276352,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-07T13:04:53.741037Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1916965358,"revision":5628,"compact-revision":2908}