{"level":"warn","ts":"2026-04-08T13:00:31.303409Z","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-08T13:00:31.303561Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.115: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.115:2380","--initial-cluster=instance=https://199.204.45.115:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.115:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.115: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-08T13:00:31.303663Z","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-08T13:00:31.303683Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-04-08T13:00:31.303711Z","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-08T13:00:31.304655Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"]} {"level":"info","ts":"2026-04-08T13:00:31.304784Z","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.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.115: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-08T13:00:31.308939Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.840457ms"} {"level":"info","ts":"2026-04-08T13:00:31.314694Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e3aaa5c123e150e0","cluster-id":"61ec519698823541"} {"level":"info","ts":"2026-04-08T13:00:31.314887Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T13:00:31.31492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 0"} {"level":"info","ts":"2026-04-08T13:00:31.314937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e3aaa5c123e150e0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T13:00:31.314957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 1"} {"level":"info","ts":"2026-04-08T13:00:31.315003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"warn","ts":"2026-04-08T13:00:31.321887Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T13:00:31.32396Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T13:00:31.32522Z","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-08T13:00:31.328227Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e3aaa5c123e150e0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T13:00:31.328518Z","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-08T13:00:31.328684Z","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-08T13:00:31.32851Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e3aaa5c123e150e0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T13:00:31.328708Z","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-08T13:00:31.330993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"info","ts":"2026-04-08T13:00:31.331995Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","added-peer-id":"e3aaa5c123e150e0","added-peer-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-04-08T13:00:31.334221Z","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-08T13:00:31.334579Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e3aaa5c123e150e0","initial-advertise-peer-urls":["https://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T13:00:31.334624Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T13:00:31.33481Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-04-08T13:00:31.334879Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-04-08T13:00:32.116299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T13:00:32.11654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T13:00:32.116651Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgPreVoteResp from e3aaa5c123e150e0 at term 1"} {"level":"info","ts":"2026-04-08T13:00:32.116734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became candidate at term 2"} {"level":"info","ts":"2026-04-08T13:00:32.116797Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgVoteResp from e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-04-08T13:00:32.116854Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became leader at term 2"} {"level":"info","ts":"2026-04-08T13:00:32.116927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e3aaa5c123e150e0 elected leader e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-04-08T13:00:32.118248Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T13:00:32.118962Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e3aaa5c123e150e0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.115:2379]}","request-path":"/0/members/e3aaa5c123e150e0/attributes","cluster-id":"61ec519698823541","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T13:00:32.119203Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T13:00:32.119331Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T13:00:32.119461Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T13:00:32.119531Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T13:00:32.119581Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T13:00:32.119778Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T13:00:32.119889Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T13:00:32.122965Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T13:00:32.12397Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.115:2379"} {"level":"info","ts":"2026-04-08T13:01:05.508522Z","caller":"traceutil/trace.go:171","msg":"trace[1210216156] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"110.114196ms","start":"2026-04-08T13:01:05.398358Z","end":"2026-04-08T13:01:05.508472Z","steps":["trace[1210216156] 'process raft request' (duration: 109.787339ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:01:05.809653Z","caller":"traceutil/trace.go:171","msg":"trace[407478693] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"189.880626ms","start":"2026-04-08T13:01:05.619701Z","end":"2026-04-08T13:01:05.809581Z","steps":["trace[407478693] 'process raft request' (duration: 187.24289ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:01:05.809765Z","caller":"traceutil/trace.go:171","msg":"trace[1105849008] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"205.698407ms","start":"2026-04-08T13:01:05.601344Z","end":"2026-04-08T13:01:05.807043Z","steps":["trace[1105849008] 'process raft request' (duration: 113.953246ms)","trace[1105849008] 'compare' (duration: 90.886893ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T13:01:11.899106Z","caller":"traceutil/trace.go:171","msg":"trace[397629159] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"232.017709ms","start":"2026-04-08T13:01:11.667024Z","end":"2026-04-08T13:01:11.899042Z","steps":["trace[397629159] 'process raft request' (duration: 229.591868ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:01:12.282051Z","caller":"traceutil/trace.go:171","msg":"trace[1726152516] linearizableReadLoop","detail":"{readStateIndex:596; appliedIndex:595; }","duration":"284.478557ms","start":"2026-04-08T13:01:11.99753Z","end":"2026-04-08T13:01:12.282009Z","steps":["trace[1726152516] 'read index received' (duration: 284.173831ms)","trace[1726152516] 'applied index is now lower than readState.Index' (duration: 303.166µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T13:01:12.282437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.877195ms","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-08T13:01:12.28259Z","caller":"traceutil/trace.go:171","msg":"trace[1450326671] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:574; }","duration":"285.108701ms","start":"2026-04-08T13:01:11.99745Z","end":"2026-04-08T13:01:12.282559Z","steps":["trace[1450326671] 'agreement among raft nodes before linearized reading' (duration: 284.697002ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:01:12.283005Z","caller":"traceutil/trace.go:171","msg":"trace[591562276] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"320.157464ms","start":"2026-04-08T13:01:11.96279Z","end":"2026-04-08T13:01:12.282948Z","steps":["trace[591562276] 'process raft request' (duration: 319.0305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:01:12.283767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T13:01:11.962735Z","time spent":"320.406109ms","remote":"127.0.0.1:39284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T13:01:12.623764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.604335ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T13:01:12.624042Z","caller":"traceutil/trace.go:171","msg":"trace[1601449537] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"323.632607ms","start":"2026-04-08T13:01:12.300388Z","end":"2026-04-08T13:01:12.624021Z","steps":["trace[1601449537] 'process raft request' (duration: 323.525285ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:01:12.62402Z","caller":"traceutil/trace.go:171","msg":"trace[1536255692] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"336.452745ms","start":"2026-04-08T13:01:12.287516Z","end":"2026-04-08T13:01:12.623969Z","steps":["trace[1536255692] 'process raft request' (duration: 163.235238ms)","trace[1536255692] 'compare' (duration: 172.374599ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T13:01:12.624136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T13:01:12.300355Z","time spent":"323.74372ms","remote":"127.0.0.1:39226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T13:01:12.624165Z","caller":"traceutil/trace.go:171","msg":"trace[1611996734] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:596; }","duration":"332.34766ms","start":"2026-04-08T13:01:12.291752Z","end":"2026-04-08T13:01:12.6241Z","steps":["trace[1611996734] 'read index received' (duration: 159.098712ms)","trace[1611996734] 'applied index is now lower than readState.Index' (duration: 173.242588ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T13:01:12.62423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T13:01:12.28748Z","time spent":"336.641149ms","remote":"127.0.0.1:39304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T13:01:12.624312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.561454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-08T13:01:12.624351Z","caller":"traceutil/trace.go:171","msg":"trace[42179785] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:576; }","duration":"332.598755ms","start":"2026-04-08T13:01:12.291741Z","end":"2026-04-08T13:01:12.624339Z","steps":["trace[42179785] 'agreement among raft nodes before linearized reading' (duration: 332.522793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:01:12.624382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T13:01:12.291668Z","time spent":"332.706957ms","remote":"127.0.0.1:39242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-04-08T13:01:12.624421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.798136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T13:01:12.624472Z","caller":"traceutil/trace.go:171","msg":"trace[471593532] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:576; }","duration":"244.920948ms","start":"2026-04-08T13:01:12.379537Z","end":"2026-04-08T13:01:12.624458Z","steps":["trace[471593532] 'agreement among raft nodes before linearized reading' (duration: 244.810926ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:01:12.624464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.969742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-08T13:01:12.624531Z","caller":"traceutil/trace.go:171","msg":"trace[721551993] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:576; }","duration":"152.076224ms","start":"2026-04-08T13:01:12.472436Z","end":"2026-04-08T13:01:12.624512Z","steps":["trace[721551993] 'agreement among raft nodes before linearized reading' (duration: 151.940332ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:01:12.624526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.499373ms","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-08T13:01:12.624591Z","caller":"traceutil/trace.go:171","msg":"trace[22087055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:576; }","duration":"152.599415ms","start":"2026-04-08T13:01:12.471975Z","end":"2026-04-08T13:01:12.624575Z","steps":["trace[22087055] 'agreement among raft nodes before linearized reading' (duration: 152.454882ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:01:13.135619Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831010067929102,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-08T13:01:13.329764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.634942ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T13:01:13.329932Z","caller":"traceutil/trace.go:171","msg":"trace[284914172] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"700.431817ms","start":"2026-04-08T13:01:12.62947Z","end":"2026-04-08T13:01:13.329902Z","steps":["trace[284914172] 'process raft request' (duration: 562.528129ms)","trace[284914172] 'compare' (duration: 137.424558ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T13:01:13.330046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T13:01:12.629448Z","time spent":"700.54898ms","remote":"127.0.0.1:39304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T13:01:13.436641Z","caller":"traceutil/trace.go:171","msg":"trace[910129398] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:598; }","duration":"801.785319ms","start":"2026-04-08T13:01:12.634835Z","end":"2026-04-08T13:01:13.43662Z","steps":["trace[910129398] 'read index received' (duration: 557.188077ms)","trace[910129398] 'applied index is now lower than readState.Index' (duration: 244.595622ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T13:01:13.436745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"801.904652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T13:01:13.436724Z","caller":"traceutil/trace.go:171","msg":"trace[1547050662] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"806.981348ms","start":"2026-04-08T13:01:12.629698Z","end":"2026-04-08T13:01:13.43668Z","steps":["trace[1547050662] 'process raft request' (duration: 804.550657ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:01:13.43677Z","caller":"traceutil/trace.go:171","msg":"trace[603217182] range","detail":"{range_begin:/registry/limitranges/envoy-gateway-system/; range_end:/registry/limitranges/envoy-gateway-system0; response_count:0; response_revision:578; }","duration":"801.975293ms","start":"2026-04-08T13:01:12.634784Z","end":"2026-04-08T13:01:13.436759Z","steps":["trace[603217182] 'agreement among raft nodes before linearized reading' (duration: 801.906452ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:01:13.436917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T13:01:12.629685Z","time spent":"807.126321ms","remote":"127.0.0.1:39304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T13:01:13.436957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T13:01:12.634772Z","time spent":"802.174668ms","remote":"127.0.0.1:39170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" "} {"level":"info","ts":"2026-04-08T13:01:15.559365Z","caller":"traceutil/trace.go:171","msg":"trace[1965821512] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"116.175444ms","start":"2026-04-08T13:01:15.443154Z","end":"2026-04-08T13:01:15.55933Z","steps":["trace[1965821512] 'process raft request' (duration: 115.97854ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:01:15.560823Z","caller":"traceutil/trace.go:171","msg":"trace[2119533122] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"114.744413ms","start":"2026-04-08T13:01:15.446051Z","end":"2026-04-08T13:01:15.560795Z","steps":["trace[2119533122] 'process raft request' (duration: 114.59552ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:01:57.656164Z","caller":"traceutil/trace.go:171","msg":"trace[1788317004] linearizableReadLoop","detail":"{readStateIndex:1165; appliedIndex:1164; }","duration":"278.082073ms","start":"2026-04-08T13:01:57.378051Z","end":"2026-04-08T13:01:57.656133Z","steps":["trace[1788317004] 'read index received' (duration: 277.97383ms)","trace[1788317004] 'applied index is now lower than readState.Index' (duration: 107.043µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T13:01:57.656289Z","caller":"traceutil/trace.go:171","msg":"trace[950421408] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"289.180975ms","start":"2026-04-08T13:01:57.367047Z","end":"2026-04-08T13:01:57.656228Z","steps":["trace[950421408] 'process raft request' (duration: 288.903999ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:01:57.65639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.309437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T13:01:57.656508Z","caller":"traceutil/trace.go:171","msg":"trace[823517124] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1132; }","duration":"278.498071ms","start":"2026-04-08T13:01:57.377985Z","end":"2026-04-08T13:01:57.656484Z","steps":["trace[823517124] 'agreement among raft nodes before linearized reading' (duration: 278.270786ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:02:46.987947Z","caller":"traceutil/trace.go:171","msg":"trace[670933557] transaction","detail":"{read_only:false; response_revision:1808; number_of_response:1; }","duration":"114.888695ms","start":"2026-04-08T13:02:46.873006Z","end":"2026-04-08T13:02:46.987894Z","steps":["trace[670933557] 'process raft request' (duration: 114.443096ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:02:47.354606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.621738ms","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-08T13:02:47.354752Z","caller":"traceutil/trace.go:171","msg":"trace[1855223192] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1808; }","duration":"293.806672ms","start":"2026-04-08T13:02:47.060889Z","end":"2026-04-08T13:02:47.354696Z","steps":["trace[1855223192] 'range keys from in-memory index tree' (duration: 293.344532ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:02:47.35487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.295718ms","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-08T13:02:47.355032Z","caller":"traceutil/trace.go:171","msg":"trace[1216301132] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1808; }","duration":"215.489342ms","start":"2026-04-08T13:02:47.139505Z","end":"2026-04-08T13:02:47.354994Z","steps":["trace[1216301132] 'range keys from in-memory index tree' (duration: 214.856479ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:04:26.738796Z","caller":"traceutil/trace.go:171","msg":"trace[1659520523] transaction","detail":"{read_only:false; response_revision:2577; number_of_response:1; }","duration":"170.421239ms","start":"2026-04-08T13:04:26.568346Z","end":"2026-04-08T13:04:26.738767Z","steps":["trace[1659520523] 'process raft request' (duration: 164.233618ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:05:01.037702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.097957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" ","response":"range_response_count:1 size:1443"} {"level":"info","ts":"2026-04-08T13:05:01.037835Z","caller":"traceutil/trace.go:171","msg":"trace[1161660542] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-metrics; range_end:; response_count:1; response_revision:2782; }","duration":"133.28815ms","start":"2026-04-08T13:05:00.904521Z","end":"2026-04-08T13:05:01.037809Z","steps":["trace[1161660542] 'range keys from in-memory index tree' (duration: 132.818501ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:05:01.03782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.473148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-08T13:05:01.037893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.238723ms","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-08T13:05:01.037945Z","caller":"traceutil/trace.go:171","msg":"trace[1897958303] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2782; }","duration":"114.681072ms","start":"2026-04-08T13:05:00.923234Z","end":"2026-04-08T13:05:01.037915Z","steps":["trace[1897958303] 'range keys from in-memory index tree' (duration: 114.208452ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:05:01.038023Z","caller":"traceutil/trace.go:171","msg":"trace[415274303] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2782; }","duration":"115.412457ms","start":"2026-04-08T13:05:00.92258Z","end":"2026-04-08T13:05:01.037993Z","steps":["trace[415274303] 'range keys from in-memory index tree' (duration: 114.994368ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:08:59.210305Z","caller":"traceutil/trace.go:171","msg":"trace[1511190723] transaction","detail":"{read_only:false; response_revision:4878; number_of_response:1; }","duration":"104.94391ms","start":"2026-04-08T13:08:59.105326Z","end":"2026-04-08T13:08:59.21027Z","steps":["trace[1511190723] 'process raft request' (duration: 104.624414ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:09:03.183104Z","caller":"traceutil/trace.go:171","msg":"trace[1456810523] linearizableReadLoop","detail":"{readStateIndex:5201; appliedIndex:5200; }","duration":"124.732129ms","start":"2026-04-08T13:09:03.058351Z","end":"2026-04-08T13:09:03.183083Z","steps":["trace[1456810523] 'read index received' (duration: 124.694968ms)","trace[1456810523] 'applied index is now lower than readState.Index' (duration: 35.811µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T13:09:03.183199Z","caller":"traceutil/trace.go:171","msg":"trace[1828344000] transaction","detail":"{read_only:false; response_revision:5014; number_of_response:1; }","duration":"140.257788ms","start":"2026-04-08T13:09:03.042902Z","end":"2026-04-08T13:09:03.18316Z","steps":["trace[1828344000] 'process raft request' (duration: 140.071544ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:09:03.183267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.913692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-lrlkq-tls\" ","response":"range_response_count:1 size:1967"} {"level":"info","ts":"2026-04-08T13:09:03.183291Z","caller":"traceutil/trace.go:171","msg":"trace[1221345258] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-lrlkq-tls; range_end:; response_count:1; response_revision:5014; }","duration":"124.992954ms","start":"2026-04-08T13:09:03.058291Z","end":"2026-04-08T13:09:03.183284Z","steps":["trace[1221345258] 'agreement among raft nodes before linearized reading' (duration: 124.865302ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:09:03.311767Z","caller":"traceutil/trace.go:171","msg":"trace[1310551997] linearizableReadLoop","detail":"{readStateIndex:5202; appliedIndex:5201; }","duration":"115.379912ms","start":"2026-04-08T13:09:03.196366Z","end":"2026-04-08T13:09:03.311746Z","steps":["trace[1310551997] 'read index received' (duration: 115.029925ms)","trace[1310551997] 'applied index is now lower than readState.Index' (duration: 348.947µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T13:09:03.311835Z","caller":"traceutil/trace.go:171","msg":"trace[475875235] transaction","detail":"{read_only:false; response_revision:5015; number_of_response:1; }","duration":"238.920635ms","start":"2026-04-08T13:09:03.072894Z","end":"2026-04-08T13:09:03.311815Z","steps":["trace[475875235] 'process raft request' (duration: 238.545478ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:09:03.311975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.595616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-59e4cb59-24fa-4ed2-af06-b0d75d92e8aa\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-04-08T13:09:03.31201Z","caller":"traceutil/trace.go:171","msg":"trace[1197939741] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-59e4cb59-24fa-4ed2-af06-b0d75d92e8aa; range_end:; response_count:1; response_revision:5015; }","duration":"115.680918ms","start":"2026-04-08T13:09:03.196319Z","end":"2026-04-08T13:09:03.312Z","steps":["trace[1197939741] 'agreement among raft nodes before linearized reading' (duration: 115.532215ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:09:03.513613Z","caller":"traceutil/trace.go:171","msg":"trace[1673990362] transaction","detail":"{read_only:false; response_revision:5016; number_of_response:1; }","duration":"315.800032ms","start":"2026-04-08T13:09:03.197793Z","end":"2026-04-08T13:09:03.513593Z","steps":["trace[1673990362] 'process raft request' (duration: 247.425296ms)","trace[1673990362] 'compare' (duration: 68.08302ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T13:09:03.513636Z","caller":"traceutil/trace.go:171","msg":"trace[1887822551] transaction","detail":"{read_only:false; response_revision:5017; number_of_response:1; }","duration":"164.744016ms","start":"2026-04-08T13:09:03.348869Z","end":"2026-04-08T13:09:03.513614Z","steps":["trace[1887822551] 'process raft request' (duration: 164.638224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:09:03.513809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T13:09:03.197762Z","time spent":"315.912615ms","remote":"127.0.0.1:39242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":879,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T13:09:03.513854Z","caller":"traceutil/trace.go:171","msg":"trace[551040665] linearizableReadLoop","detail":"{readStateIndex:5203; appliedIndex:5202; }","duration":"202.002354ms","start":"2026-04-08T13:09:03.311829Z","end":"2026-04-08T13:09:03.513831Z","steps":["trace[551040665] 'read index received' (duration: 133.381443ms)","trace[551040665] 'applied index is now lower than readState.Index' (duration: 68.617741ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T13:09:03.513983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.784514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T13:09:03.514019Z","caller":"traceutil/trace.go:171","msg":"trace[775443902] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5017; }","duration":"136.828455ms","start":"2026-04-08T13:09:03.377183Z","end":"2026-04-08T13:09:03.514011Z","steps":["trace[775443902] 'agreement among raft nodes before linearized reading' (duration: 136.760924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:09:03.514052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.846495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-lrlkq-tls\" ","response":"range_response_count:1 size:4432"} {"level":"info","ts":"2026-04-08T13:09:03.514084Z","caller":"traceutil/trace.go:171","msg":"trace[440126085] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-lrlkq-tls; range_end:; response_count:1; response_revision:5017; }","duration":"316.922087ms","start":"2026-04-08T13:09:03.197152Z","end":"2026-04-08T13:09:03.514074Z","steps":["trace[440126085] 'agreement among raft nodes before linearized reading' (duration: 316.782913ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:09:03.514113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T13:09:03.197133Z","time spent":"316.974189ms","remote":"127.0.0.1:39130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":1,"response size":4455,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-lrlkq-tls\" "} {"level":"info","ts":"2026-04-08T13:09:03.928868Z","caller":"traceutil/trace.go:171","msg":"trace[306008235] transaction","detail":"{read_only:false; response_revision:5028; number_of_response:1; }","duration":"221.426256ms","start":"2026-04-08T13:09:03.707418Z","end":"2026-04-08T13:09:03.928844Z","steps":["trace[306008235] 'process raft request' (duration: 221.235911ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:09:03.943358Z","caller":"traceutil/trace.go:171","msg":"trace[725008949] transaction","detail":"{read_only:false; response_revision:5029; number_of_response:1; }","duration":"200.153096ms","start":"2026-04-08T13:09:03.743166Z","end":"2026-04-08T13:09:03.943319Z","steps":["trace[725008949] 'process raft request' (duration: 199.947712ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:09:03.94358Z","caller":"traceutil/trace.go:171","msg":"trace[462856594] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-59e4cb59-24fa-4ed2-af06-b0d75d92e8aa; range_end:; response_count:1; response_revision:5029; }","duration":"100.026007ms","start":"2026-04-08T13:09:03.843526Z","end":"2026-04-08T13:09:03.943552Z","steps":["trace[462856594] 'agreement among raft nodes before linearized reading' (duration: 99.814263ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:09:15.148118Z","caller":"traceutil/trace.go:171","msg":"trace[581299592] transaction","detail":"{read_only:false; response_revision:5245; number_of_response:1; }","duration":"171.745974ms","start":"2026-04-08T13:09:14.976339Z","end":"2026-04-08T13:09:15.148085Z","steps":["trace[581299592] 'process raft request' (duration: 171.471698ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:09:22.586403Z","caller":"traceutil/trace.go:171","msg":"trace[248623472] linearizableReadLoop","detail":"{readStateIndex:5611; appliedIndex:5610; }","duration":"106.290689ms","start":"2026-04-08T13:09:22.480083Z","end":"2026-04-08T13:09:22.586374Z","steps":["trace[248623472] 'read index received' (duration: 106.073005ms)","trace[248623472] 'applied index is now lower than readState.Index' (duration: 216.234µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T13:09:22.586514Z","caller":"traceutil/trace.go:171","msg":"trace[600425482] transaction","detail":"{read_only:false; response_revision:5412; number_of_response:1; }","duration":"129.870799ms","start":"2026-04-08T13:09:22.45661Z","end":"2026-04-08T13:09:22.586481Z","steps":["trace[600425482] 'process raft request' (duration: 129.574903ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:09:22.586679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.578046ms","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-08T13:09:22.586773Z","caller":"traceutil/trace.go:171","msg":"trace[48810437] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5412; }","duration":"106.720858ms","start":"2026-04-08T13:09:22.479992Z","end":"2026-04-08T13:09:22.586713Z","steps":["trace[48810437] 'agreement among raft nodes before linearized reading' (duration: 106.546465ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:09:22.876838Z","caller":"traceutil/trace.go:171","msg":"trace[1496645457] transaction","detail":"{read_only:false; response_revision:5414; number_of_response:1; }","duration":"117.220819ms","start":"2026-04-08T13:09:22.759582Z","end":"2026-04-08T13:09:22.876803Z","steps":["trace[1496645457] 'process raft request' (duration: 49.17771ms)","trace[1496645457] 'compare' (duration: 67.785414ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T13:10:32.147399Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2954} {"level":"info","ts":"2026-04-08T13:10:32.232841Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2954,"took":"83.687461ms","hash":3491525450,"current-db-size-bytes":58413056,"current-db-size":"58 MB","current-db-size-in-use-bytes":33390592,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-08T13:10:32.233015Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3491525450,"revision":2954,"compact-revision":-1} {"level":"info","ts":"2026-04-08T13:15:21.689876Z","caller":"traceutil/trace.go:171","msg":"trace[1224002580] linearizableReadLoop","detail":"{readStateIndex:8496; appliedIndex:8495; }","duration":"182.912584ms","start":"2026-04-08T13:15:21.506925Z","end":"2026-04-08T13:15:21.689838Z","steps":["trace[1224002580] 'read index received' (duration: 182.535536ms)","trace[1224002580] 'applied index is now lower than readState.Index' (duration: 375.388µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T13:15:21.68998Z","caller":"traceutil/trace.go:171","msg":"trace[307246152] transaction","detail":"{read_only:false; response_revision:8212; number_of_response:1; }","duration":"258.565692ms","start":"2026-04-08T13:15:21.431337Z","end":"2026-04-08T13:15:21.689903Z","steps":["trace[307246152] 'process raft request' (duration: 258.263736ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:15:21.690211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.270151ms","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-08T13:15:21.690306Z","caller":"traceutil/trace.go:171","msg":"trace[993742926] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8212; }","duration":"183.409465ms","start":"2026-04-08T13:15:21.506877Z","end":"2026-04-08T13:15:21.690287Z","steps":["trace[993742926] 'agreement among raft nodes before linearized reading' (duration: 183.153259ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:15:21.812038Z","caller":"traceutil/trace.go:171","msg":"trace[711758119] linearizableReadLoop","detail":"{readStateIndex:8498; appliedIndex:8496; }","duration":"112.080159ms","start":"2026-04-08T13:15:21.699933Z","end":"2026-04-08T13:15:21.812013Z","steps":["trace[711758119] 'read index received' (duration: 73.527783ms)","trace[711758119] 'applied index is now lower than readState.Index' (duration: 38.551176ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T13:15:21.812118Z","caller":"traceutil/trace.go:171","msg":"trace[246214203] transaction","detail":"{read_only:false; response_revision:8213; number_of_response:1; }","duration":"117.685238ms","start":"2026-04-08T13:15:21.694403Z","end":"2026-04-08T13:15:21.812088Z","steps":["trace[246214203] 'process raft request' (duration: 79.034461ms)","trace[246214203] 'compare' (duration: 38.373811ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T13:15:21.812249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.310933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-08T13:15:21.81229Z","caller":"traceutil/trace.go:171","msg":"trace[834565030] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8214; }","duration":"112.369674ms","start":"2026-04-08T13:15:21.699911Z","end":"2026-04-08T13:15:21.81228Z","steps":["trace[834565030] 'agreement among raft nodes before linearized reading' (duration: 112.201461ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:15:21.812371Z","caller":"traceutil/trace.go:171","msg":"trace[1449454463] transaction","detail":"{read_only:false; response_revision:8214; number_of_response:1; }","duration":"117.226549ms","start":"2026-04-08T13:15:21.695089Z","end":"2026-04-08T13:15:21.812316Z","steps":["trace[1449454463] 'process raft request' (duration: 116.873822ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:15:32.156369Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6055} {"level":"info","ts":"2026-04-08T13:15:32.434303Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6055,"took":"275.874264ms","hash":3901940292,"current-db-size-bytes":58413056,"current-db-size":"58 MB","current-db-size-in-use-bytes":23699456,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-08T13:15:32.434477Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3901940292,"revision":6055,"compact-revision":2954} {"level":"info","ts":"2026-04-08T13:15:32.950588Z","caller":"traceutil/trace.go:171","msg":"trace[1787138570] transaction","detail":"{read_only:false; response_revision:8273; number_of_response:1; }","duration":"150.680365ms","start":"2026-04-08T13:15:32.799879Z","end":"2026-04-08T13:15:32.950559Z","steps":["trace[1787138570] 'process raft request' (duration: 150.521611ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:15:33.90235Z","caller":"traceutil/trace.go:171","msg":"trace[1900850058] transaction","detail":"{read_only:false; response_revision:8276; number_of_response:1; }","duration":"169.846475ms","start":"2026-04-08T13:15:33.732473Z","end":"2026-04-08T13:15:33.90232Z","steps":["trace[1900850058] 'process raft request' (duration: 169.641751ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:15:33.952186Z","caller":"traceutil/trace.go:171","msg":"trace[1710765604] transaction","detail":"{read_only:false; response_revision:8277; number_of_response:1; }","duration":"184.337285ms","start":"2026-04-08T13:15:33.767815Z","end":"2026-04-08T13:15:33.952152Z","steps":["trace[1710765604] 'process raft request' (duration: 165.507371ms)","trace[1710765604] 'compare' (duration: 18.626098ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T13:16:02.712254Z","caller":"traceutil/trace.go:171","msg":"trace[133358004] transaction","detail":"{read_only:false; response_revision:8484; number_of_response:1; }","duration":"126.340013ms","start":"2026-04-08T13:16:02.585873Z","end":"2026-04-08T13:16:02.712213Z","steps":["trace[133358004] 'process raft request' (duration: 126.157329ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:16:02.712702Z","caller":"traceutil/trace.go:171","msg":"trace[1924509052] linearizableReadLoop","detail":"{readStateIndex:8780; appliedIndex:8780; }","duration":"120.720763ms","start":"2026-04-08T13:16:02.591971Z","end":"2026-04-08T13:16:02.712692Z","steps":["trace[1924509052] 'read index received' (duration: 120.716893ms)","trace[1924509052] 'applied index is now lower than readState.Index' (duration: 3.16µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T13:16:02.712949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.825505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:414469"} {"level":"info","ts":"2026-04-08T13:16:02.712985Z","caller":"traceutil/trace.go:171","msg":"trace[1213237632] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:8484; }","duration":"120.906967ms","start":"2026-04-08T13:16:02.59207Z","end":"2026-04-08T13:16:02.712977Z","steps":["trace[1213237632] 'agreement among raft nodes before linearized reading' (duration: 120.695262ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:16:02.713293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.317955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-08T13:16:02.71333Z","caller":"traceutil/trace.go:171","msg":"trace[1100922296] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8484; }","duration":"121.377727ms","start":"2026-04-08T13:16:02.591944Z","end":"2026-04-08T13:16:02.713322Z","steps":["trace[1100922296] 'agreement among raft nodes before linearized reading' (duration: 121.281935ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:16:02.915686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.515556ms","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-08T13:16:02.91581Z","caller":"traceutil/trace.go:171","msg":"trace[1557287222] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8484; }","duration":"125.658309ms","start":"2026-04-08T13:16:02.790136Z","end":"2026-04-08T13:16:02.915795Z","steps":["trace[1557287222] 'range keys from in-memory index tree' (duration: 125.383093ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:16:02.915853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.112147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T13:16:02.915929Z","caller":"traceutil/trace.go:171","msg":"trace[519941084] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8484; }","duration":"124.215899ms","start":"2026-04-08T13:16:02.791694Z","end":"2026-04-08T13:16:02.91591Z","steps":["trace[519941084] 'range keys from in-memory index tree' (duration: 124.072855ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:16:02.915923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.399556ms","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-08T13:16:02.915996Z","caller":"traceutil/trace.go:171","msg":"trace[588956897] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8484; }","duration":"127.514389ms","start":"2026-04-08T13:16:02.788464Z","end":"2026-04-08T13:16:02.915978Z","steps":["trace[588956897] 'range keys from in-memory index tree' (duration: 127.208823ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:16:04.205055Z","caller":"traceutil/trace.go:171","msg":"trace[1118883247] transaction","detail":"{read_only:false; response_revision:8492; number_of_response:1; }","duration":"114.655623ms","start":"2026-04-08T13:16:04.090367Z","end":"2026-04-08T13:16:04.205023Z","steps":["trace[1118883247] 'process raft request' (duration: 114.457419ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:16:14.937985Z","caller":"traceutil/trace.go:171","msg":"trace[1884888764] linearizableReadLoop","detail":"{readStateIndex:8886; appliedIndex:8885; }","duration":"160.595406ms","start":"2026-04-08T13:16:14.777361Z","end":"2026-04-08T13:16:14.937956Z","steps":["trace[1884888764] 'read index received' (duration: 72.190135ms)","trace[1884888764] 'applied index is now lower than readState.Index' (duration: 88.403931ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T13:16:14.938233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.505635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-detect-version\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-04-08T13:16:14.938274Z","caller":"traceutil/trace.go:171","msg":"trace[1655051203] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-detect-version; range_end:; response_count:1; response_revision:8586; }","duration":"161.582686ms","start":"2026-04-08T13:16:14.776679Z","end":"2026-04-08T13:16:14.938262Z","steps":["trace[1655051203] 'agreement among raft nodes before linearized reading' (duration: 161.415833ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:16:14.938259Z","caller":"traceutil/trace.go:171","msg":"trace[315308590] transaction","detail":"{read_only:false; response_revision:8586; number_of_response:1; }","duration":"162.350814ms","start":"2026-04-08T13:16:14.775768Z","end":"2026-04-08T13:16:14.938119Z","steps":["trace[315308590] 'process raft request' (duration: 73.825191ms)","trace[315308590] 'compare' (duration: 88.211507ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T13:16:14.946495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.787718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/rook-ceph-detect-version\" ","response":"range_response_count:1 size:3066"} {"level":"info","ts":"2026-04-08T13:16:14.946597Z","caller":"traceutil/trace.go:171","msg":"trace[522272412] range","detail":"{range_begin:/registry/jobs/openstack/rook-ceph-detect-version; range_end:; response_count:1; response_revision:8587; }","duration":"166.917021ms","start":"2026-04-08T13:16:14.779659Z","end":"2026-04-08T13:16:14.946576Z","steps":["trace[522272412] 'agreement among raft nodes before linearized reading' (duration: 166.636465ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:16:15.863713Z","caller":"traceutil/trace.go:171","msg":"trace[1365822526] transaction","detail":"{read_only:false; response_revision:8598; number_of_response:1; }","duration":"226.082148ms","start":"2026-04-08T13:16:15.637608Z","end":"2026-04-08T13:16:15.86369Z","steps":["trace[1365822526] 'process raft request' (duration: 225.915104ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:16:16.029864Z","caller":"traceutil/trace.go:171","msg":"trace[1135856815] linearizableReadLoop","detail":"{readStateIndex:8900; appliedIndex:8898; }","duration":"257.061911ms","start":"2026-04-08T13:16:15.77277Z","end":"2026-04-08T13:16:16.029832Z","steps":["trace[1135856815] 'read index received' (duration: 90.784023ms)","trace[1135856815] 'applied index is now lower than readState.Index' (duration: 166.276607ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T13:16:16.029957Z","caller":"traceutil/trace.go:171","msg":"trace[748906254] transaction","detail":"{read_only:false; response_revision:8599; number_of_response:1; }","duration":"380.500332ms","start":"2026-04-08T13:16:15.649448Z","end":"2026-04-08T13:16:16.029948Z","steps":["trace[748906254] 'process raft request' (duration: 333.577858ms)","trace[748906254] 'compare' (duration: 46.7119ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T13:16:16.030045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T13:16:15.649425Z","time spent":"380.551484ms","remote":"127.0.0.1:39284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3037,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T13:16:16.030229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.430088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T13:16:16.03029Z","caller":"traceutil/trace.go:171","msg":"trace[635933867] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:8599; }","duration":"257.576142ms","start":"2026-04-08T13:16:15.772699Z","end":"2026-04-08T13:16:16.030275Z","steps":["trace[635933867] 'agreement among raft nodes before linearized reading' (duration: 257.46643ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:16:16.06012Z","caller":"traceutil/trace.go:171","msg":"trace[1498082771] transaction","detail":"{read_only:false; response_revision:8600; number_of_response:1; }","duration":"144.433081ms","start":"2026-04-08T13:16:15.915662Z","end":"2026-04-08T13:16:16.060095Z","steps":["trace[1498082771] 'process raft request' (duration: 144.206826ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:16:16.060223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.865144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5146"} {"level":"info","ts":"2026-04-08T13:16:16.06029Z","caller":"traceutil/trace.go:171","msg":"trace[1851440092] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8600; }","duration":"283.983197ms","start":"2026-04-08T13:16:15.776291Z","end":"2026-04-08T13:16:16.060274Z","steps":["trace[1851440092] 'agreement among raft nodes before linearized reading' (duration: 283.766102ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:16:38.173842Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023d7.wal"} {"level":"info","ts":"2026-04-08T13:17:04.06954Z","caller":"traceutil/trace.go:171","msg":"trace[495217792] transaction","detail":"{read_only:false; response_revision:9032; number_of_response:1; }","duration":"102.275619ms","start":"2026-04-08T13:17:03.967229Z","end":"2026-04-08T13:17:04.069504Z","steps":["trace[495217792] 'process raft request' (duration: 60.908283ms)","trace[495217792] 'compare' (duration: 41.218283ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T13:17:04.107379Z","caller":"traceutil/trace.go:171","msg":"trace[2092435462] transaction","detail":"{read_only:false; response_revision:9034; number_of_response:1; }","duration":"139.893933ms","start":"2026-04-08T13:17:03.967466Z","end":"2026-04-08T13:17:04.107359Z","steps":["trace[2092435462] 'process raft request' (duration: 139.717219ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:17:04.107483Z","caller":"traceutil/trace.go:171","msg":"trace[1185516071] transaction","detail":"{read_only:false; response_revision:9035; number_of_response:1; }","duration":"139.900574ms","start":"2026-04-08T13:17:03.967533Z","end":"2026-04-08T13:17:04.107433Z","steps":["trace[1185516071] 'process raft request' (duration: 139.70947ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:17:04.107521Z","caller":"traceutil/trace.go:171","msg":"trace[408656150] transaction","detail":"{read_only:false; response_revision:9036; number_of_response:1; }","duration":"139.876884ms","start":"2026-04-08T13:17:03.967603Z","end":"2026-04-08T13:17:04.10748Z","steps":["trace[408656150] 'process raft request' (duration: 139.69428ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:17:04.107557Z","caller":"traceutil/trace.go:171","msg":"trace[1142648799] transaction","detail":"{read_only:false; response_revision:9037; number_of_response:1; }","duration":"139.905894ms","start":"2026-04-08T13:17:03.967602Z","end":"2026-04-08T13:17:04.107508Z","steps":["trace[1142648799] 'process raft request' (duration: 139.739571ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:17:04.107737Z","caller":"traceutil/trace.go:171","msg":"trace[777376573] transaction","detail":"{read_only:false; response_revision:9040; number_of_response:1; }","duration":"139.328382ms","start":"2026-04-08T13:17:03.968388Z","end":"2026-04-08T13:17:04.107716Z","steps":["trace[777376573] 'process raft request' (duration: 139.092987ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:17:04.107729Z","caller":"traceutil/trace.go:171","msg":"trace[538949970] linearizableReadLoop","detail":"{readStateIndex:9353; appliedIndex:9345; }","duration":"139.394863ms","start":"2026-04-08T13:17:03.96831Z","end":"2026-04-08T13:17:04.107705Z","steps":["trace[538949970] 'read index received' (duration: 59.878892ms)","trace[538949970] 'applied index is now lower than readState.Index' (duration: 79.514451ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T13:17:04.107751Z","caller":"traceutil/trace.go:171","msg":"trace[798994113] transaction","detail":"{read_only:false; response_revision:9039; number_of_response:1; }","duration":"139.644608ms","start":"2026-04-08T13:17:03.96804Z","end":"2026-04-08T13:17:04.107685Z","steps":["trace[798994113] 'process raft request' (duration: 139.397683ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:17:04.107893Z","caller":"traceutil/trace.go:171","msg":"trace[606429174] transaction","detail":"{read_only:false; response_revision:9033; number_of_response:1; }","duration":"139.995786ms","start":"2026-04-08T13:17:03.967288Z","end":"2026-04-08T13:17:04.107284Z","steps":["trace[606429174] 'process raft request' (duration: 139.784161ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:17:04.108025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.69185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19336"} {"level":"info","ts":"2026-04-08T13:17:04.107632Z","caller":"traceutil/trace.go:171","msg":"trace[1919629753] transaction","detail":"{read_only:false; response_revision:9038; number_of_response:1; }","duration":"139.879453ms","start":"2026-04-08T13:17:03.967722Z","end":"2026-04-08T13:17:04.107601Z","steps":["trace[1919629753] 'process raft request' (duration: 139.658799ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:17:04.108192Z","caller":"traceutil/trace.go:171","msg":"trace[2130145455] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:9040; }","duration":"139.829422ms","start":"2026-04-08T13:17:03.968284Z","end":"2026-04-08T13:17:04.108113Z","steps":["trace[2130145455] 'agreement among raft nodes before linearized reading' (duration: 139.489945ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:17:54.041215Z","caller":"traceutil/trace.go:171","msg":"trace[1114322592] transaction","detail":"{read_only:false; response_revision:9519; number_of_response:1; }","duration":"100.000687ms","start":"2026-04-08T13:17:53.941182Z","end":"2026-04-08T13:17:54.041183Z","steps":["trace[1114322592] 'process raft request' (duration: 99.706231ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:17:54.041306Z","caller":"traceutil/trace.go:171","msg":"trace[517604961] transaction","detail":"{read_only:false; response_revision:9518; number_of_response:1; }","duration":"103.034182ms","start":"2026-04-08T13:17:53.938192Z","end":"2026-04-08T13:17:54.041226Z","steps":["trace[517604961] 'process raft request' (duration: 87.140253ms)","trace[517604961] 'compare' (duration: 15.419049ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T13:17:55.238135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.063938ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T13:17:55.238242Z","caller":"traceutil/trace.go:171","msg":"trace[1708509286] linearizableReadLoop","detail":"{readStateIndex:9849; appliedIndex:9848; }","duration":"126.803537ms","start":"2026-04-08T13:17:55.111422Z","end":"2026-04-08T13:17:55.238225Z","steps":["trace[1708509286] 'read index received' (duration: 56.811µs)","trace[1708509286] 'applied index is now lower than readState.Index' (duration: 126.745646ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T13:17:55.238494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.072472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-08T13:17:55.238537Z","caller":"traceutil/trace.go:171","msg":"trace[143084116] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9524; }","duration":"127.158734ms","start":"2026-04-08T13:17:55.111367Z","end":"2026-04-08T13:17:55.238526Z","steps":["trace[143084116] 'agreement among raft nodes before linearized reading' (duration: 126.902809ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:17:55.238765Z","caller":"traceutil/trace.go:171","msg":"trace[1306613326] transaction","detail":"{read_only:false; response_revision:9524; number_of_response:1; }","duration":"219.399097ms","start":"2026-04-08T13:17:55.019304Z","end":"2026-04-08T13:17:55.238703Z","steps":["trace[1306613326] 'process raft request' (duration: 48.682166ms)","trace[1306613326] 'compare' (duration: 169.965305ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T13:18:17.346824Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e3aaa5c123e150e0","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-08T13:18:17.355858Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-08T13:18:17.355962Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-08T13:20:32.163409Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8268} {"level":"info","ts":"2026-04-08T13:20:32.242234Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8268,"took":"76.328581ms","hash":1753635927,"current-db-size-bytes":58413056,"current-db-size":"58 MB","current-db-size-in-use-bytes":24887296,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-08T13:20:32.242335Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1753635927,"revision":8268,"compact-revision":6055} {"level":"info","ts":"2026-04-08T13:25:32.170205Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10666} {"level":"info","ts":"2026-04-08T13:25:32.247933Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10666,"took":"75.648031ms","hash":3540380943,"current-db-size-bytes":58413056,"current-db-size":"58 MB","current-db-size-in-use-bytes":20549632,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-08T13:25:32.247987Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3540380943,"revision":10666,"compact-revision":8268}