{"level":"warn","ts":"2026-04-07T05:51:46.67213Z","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-07T05:51:46.67224Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.248:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.248:2380","--initial-cluster=instance=https://199.204.45.248:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.248:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.248:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-07T05:51:46.67236Z","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-07T05:51:46.67238Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-04-07T05:51:46.672404Z","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-07T05:51:46.673241Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"]} {"level":"info","ts":"2026-04-07T05:51:46.673324Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.248:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-07T05:51:46.677839Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.235317ms"} {"level":"info","ts":"2026-04-07T05:51:46.688279Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39582465ceaa2f67","cluster-id":"87fd8ddedde3be45"} {"level":"info","ts":"2026-04-07T05:51:46.688365Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T05:51:46.688384Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 0"} {"level":"info","ts":"2026-04-07T05:51:46.688394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39582465ceaa2f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T05:51:46.688401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 1"} {"level":"info","ts":"2026-04-07T05:51:46.688429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"warn","ts":"2026-04-07T05:51:46.694595Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T05:51:46.695963Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T05:51:46.697261Z","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-07T05:51:46.699891Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39582465ceaa2f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T05:51:46.700107Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39582465ceaa2f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T05:51:46.700357Z","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-07T05:51:46.7005Z","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-07T05:51:46.700517Z","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-07T05:51:46.702311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"info","ts":"2026-04-07T05:51:46.702518Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","added-peer-id":"39582465ceaa2f67","added-peer-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-04-07T05:51:46.704728Z","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-07T05:51:46.704844Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-04-07T05:51:46.704884Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-04-07T05:51:46.706143Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39582465ceaa2f67","initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T05:51:46.706203Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T05:51:47.188808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T05:51:47.188883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T05:51:47.188915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgPreVoteResp from 39582465ceaa2f67 at term 1"} {"level":"info","ts":"2026-04-07T05:51:47.18894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became candidate at term 2"} {"level":"info","ts":"2026-04-07T05:51:47.188962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgVoteResp from 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-04-07T05:51:47.189023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became leader at term 2"} {"level":"info","ts":"2026-04-07T05:51:47.189045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39582465ceaa2f67 elected leader 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-04-07T05:51:47.207681Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39582465ceaa2f67","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.248:2379]}","request-path":"/0/members/39582465ceaa2f67/attributes","cluster-id":"87fd8ddedde3be45","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T05:51:47.207767Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T05:51:47.20783Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T05:51:47.207866Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:51:47.20808Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T05:51:47.208179Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T05:51:47.209709Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.248:2379"} {"level":"info","ts":"2026-04-07T05:51:47.210271Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T05:51:47.228919Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:51:47.229091Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:51:47.229142Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-07T05:52:16.71633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.202055ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T05:52:16.716528Z","caller":"traceutil/trace.go:171","msg":"trace[535086137] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"406.918922ms","start":"2026-04-07T05:52:16.309581Z","end":"2026-04-07T05:52:16.7165Z","steps":["trace[535086137] 'process raft request' (duration: 41.707959ms)","trace[535086137] 'compare' (duration: 363.981159ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:52:16.716632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:16.309563Z","time spent":"407.030956ms","remote":"127.0.0.1:53034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29546,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:52:16.768305Z","caller":"traceutil/trace.go:171","msg":"trace[264371031] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"450.267668ms","start":"2026-04-07T05:52:16.318008Z","end":"2026-04-07T05:52:16.768276Z","steps":["trace[264371031] 'process raft request' (duration: 449.830676ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:16.768409Z","caller":"traceutil/trace.go:171","msg":"trace[1468005233] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"437.201488ms","start":"2026-04-07T05:52:16.331153Z","end":"2026-04-07T05:52:16.768355Z","steps":["trace[1468005233] 'process raft request' (duration: 436.973941ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:16.76864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:16.331131Z","time spent":"437.395243ms","remote":"127.0.0.1:53034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29461,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:52:16.768656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:16.317993Z","time spent":"450.397971ms","remote":"127.0.0.1:53034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T05:52:23.178047Z","caller":"traceutil/trace.go:171","msg":"trace[1274674006] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"889.300127ms","start":"2026-04-07T05:52:22.288723Z","end":"2026-04-07T05:52:23.178023Z","steps":["trace[1274674006] 'process raft request' (duration: 888.750611ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:23.178222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:22.288689Z","time spent":"889.44666ms","remote":"127.0.0.1:53076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:52:23.548404Z","caller":"traceutil/trace.go:171","msg":"trace[34092534] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"1.082981879s","start":"2026-04-07T05:52:22.465396Z","end":"2026-04-07T05:52:23.548378Z","steps":["trace[34092534] 'process raft request' (duration: 1.082789784s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:23.548567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:22.465367Z","time spent":"1.083117512s","remote":"127.0.0.1:53238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:52:23.548617Z","caller":"traceutil/trace.go:171","msg":"trace[1993498026] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:596; }","duration":"645.147022ms","start":"2026-04-07T05:52:22.903422Z","end":"2026-04-07T05:52:23.548569Z","steps":["trace[1993498026] 'read index received' (duration: 273.840761ms)","trace[1993498026] 'applied index is now lower than readState.Index' (duration: 371.302451ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:52:23.548668Z","caller":"traceutil/trace.go:171","msg":"trace[703889561] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"708.837829ms","start":"2026-04-07T05:52:22.839772Z","end":"2026-04-07T05:52:23.54861Z","steps":["trace[703889561] 'process raft request' (duration: 708.557191ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:23.548846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.41716ms","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-07T05:52:23.5489Z","caller":"traceutil/trace.go:171","msg":"trace[605221727] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:576; }","duration":"645.509283ms","start":"2026-04-07T05:52:22.903375Z","end":"2026-04-07T05:52:23.548884Z","steps":["trace[605221727] 'agreement among raft nodes before linearized reading' (duration: 645.36212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:23.548937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:22.903357Z","time spent":"645.573035ms","remote":"127.0.0.1:53238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-07T05:52:23.548977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:22.839747Z","time spent":"709.062136ms","remote":"127.0.0.1:53146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:52:23.591664Z","caller":"traceutil/trace.go:171","msg":"trace[746461471] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"356.360959ms","start":"2026-04-07T05:52:23.235275Z","end":"2026-04-07T05:52:23.591636Z","steps":["trace[746461471] 'process raft request' (duration: 356.180623ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:23.591785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.936579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-07T05:52:23.591792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.854166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-07T05:52:23.591856Z","caller":"traceutil/trace.go:171","msg":"trace[907220179] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:577; }","duration":"656.963059ms","start":"2026-04-07T05:52:22.934879Z","end":"2026-04-07T05:52:23.591842Z","steps":["trace[907220179] 'agreement among raft nodes before linearized reading' (duration: 656.707383ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:23.591899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:22.934869Z","time spent":"657.02121ms","remote":"127.0.0.1:53238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-07T05:52:23.591855Z","caller":"traceutil/trace.go:171","msg":"trace[2107039464] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:577; }","duration":"194.054602ms","start":"2026-04-07T05:52:23.397782Z","end":"2026-04-07T05:52:23.591837Z","steps":["trace[2107039464] 'agreement among raft nodes before linearized reading' (duration: 193.872007ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:23.591924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.919298ms","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-07T05:52:23.591998Z","caller":"traceutil/trace.go:171","msg":"trace[1520061012] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:577; }","duration":"624.00054ms","start":"2026-04-07T05:52:22.967978Z","end":"2026-04-07T05:52:23.591979Z","steps":["trace[1520061012] 'agreement among raft nodes before linearized reading' (duration: 623.751603ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:23.591805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:23.23525Z","time spent":"356.482482ms","remote":"127.0.0.1:53330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T05:52:23.592055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:22.96795Z","time spent":"624.093503ms","remote":"127.0.0.1:53238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-07T05:52:25.017041Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.339102692s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-07T05:52:25.06059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.273985507s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T05:52:25.061045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.383181457s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T05:52:25.061127Z","caller":"traceutil/trace.go:171","msg":"trace[1110985099] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:577; }","duration":"1.274548152s","start":"2026-04-07T05:52:23.786546Z","end":"2026-04-07T05:52:25.061094Z","steps":["trace[1110985099] 'range keys from in-memory index tree' (duration: 1.273955666s)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:25.061342Z","caller":"traceutil/trace.go:171","msg":"trace[2057785586] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:600; }","duration":"1.459060241s","start":"2026-04-07T05:52:23.602263Z","end":"2026-04-07T05:52:25.061324Z","steps":["trace[2057785586] 'read index received' (duration: 75.656216ms)","trace[2057785586] 'applied index is now lower than readState.Index' (duration: 1.383403185s)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:52:25.061446Z","caller":"traceutil/trace.go:171","msg":"trace[1519882075] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"1.464741808s","start":"2026-04-07T05:52:23.596695Z","end":"2026-04-07T05:52:25.061437Z","steps":["trace[1519882075] 'process raft request' (duration: 1.464568862s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:25.061491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:23.596678Z","time spent":"1.464790228s","remote":"127.0.0.1:53238","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-07T05:52:25.061542Z","caller":"traceutil/trace.go:171","msg":"trace[2133137457] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"1.506992323s","start":"2026-04-07T05:52:23.554534Z","end":"2026-04-07T05:52:25.061527Z","steps":["trace[2133137457] 'process raft request' (duration: 123.218699ms)","trace[2133137457] 'compare' (duration: 1.382849348s)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:52:25.061455Z","caller":"traceutil/trace.go:171","msg":"trace[1188273495] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"1.464881842s","start":"2026-04-07T05:52:23.596521Z","end":"2026-04-07T05:52:25.061403Z","steps":["trace[1188273495] 'process raft request' (duration: 1.464642845s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:25.061651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.459342847s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T05:52:25.061716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:23.596479Z","time spent":"1.46521429s","remote":"127.0.0.1:53238","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-07T05:52:25.061721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.375650789s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:52:25.06175Z","caller":"traceutil/trace.go:171","msg":"trace[1999440558] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:581; }","duration":"1.459516594s","start":"2026-04-07T05:52:23.602209Z","end":"2026-04-07T05:52:25.061726Z","steps":["trace[1999440558] 'agreement among raft nodes before linearized reading' (duration: 1.459225386s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:25.061812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:23.602188Z","time spent":"1.459614626s","remote":"127.0.0.1:53468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" "} {"level":"info","ts":"2026-04-07T05:52:25.061962Z","caller":"traceutil/trace.go:171","msg":"trace[266397341] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"1.46516461s","start":"2026-04-07T05:52:23.596782Z","end":"2026-04-07T05:52:25.061946Z","steps":["trace[266397341] 'process raft request' (duration: 1.464508582s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:25.061684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:23.554504Z","time spent":"1.507078905s","remote":"127.0.0.1:53238","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-07T05:52:25.062059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:23.596724Z","time spent":"1.465269573s","remote":"127.0.0.1:53238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:52:25.061799Z","caller":"traceutil/trace.go:171","msg":"trace[963363338] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"1.375784944s","start":"2026-04-07T05:52:23.685997Z","end":"2026-04-07T05:52:25.061782Z","steps":["trace[963363338] 'agreement among raft nodes before linearized reading' (duration: 1.375473475s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:25.062271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:23.685961Z","time spent":"1.376192016s","remote":"127.0.0.1:52958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-07T05:52:26.467222Z","caller":"traceutil/trace.go:171","msg":"trace[868323801] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:622; }","duration":"212.766078ms","start":"2026-04-07T05:52:26.254395Z","end":"2026-04-07T05:52:26.467161Z","steps":["trace[868323801] 'read index received' (duration: 136.109394ms)","trace[868323801] 'applied index is now lower than readState.Index' (duration: 76.654964ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:52:26.467491Z","caller":"traceutil/trace.go:171","msg":"trace[1173353933] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"220.874511ms","start":"2026-04-07T05:52:26.246571Z","end":"2026-04-07T05:52:26.467446Z","steps":["trace[1173353933] 'process raft request' (duration: 143.991741ms)","trace[1173353933] 'compare' (duration: 76.121579ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:52:26.467669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.161049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:52:26.467801Z","caller":"traceutil/trace.go:171","msg":"trace[2112725425] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:599; }","duration":"213.351755ms","start":"2026-04-07T05:52:26.254418Z","end":"2026-04-07T05:52:26.467769Z","steps":["trace[2112725425] 'agreement among raft nodes before linearized reading' (duration: 213.074958ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:26.468236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.885346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:52:26.468309Z","caller":"traceutil/trace.go:171","msg":"trace[1120041936] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:599; }","duration":"153.006949ms","start":"2026-04-07T05:52:26.315282Z","end":"2026-04-07T05:52:26.468289Z","steps":["trace[1120041936] 'agreement among raft nodes before linearized reading' (duration: 152.862215ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:26.468316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.688438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:52:26.468375Z","caller":"traceutil/trace.go:171","msg":"trace[1823646642] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:599; }","duration":"153.74872ms","start":"2026-04-07T05:52:26.314609Z","end":"2026-04-07T05:52:26.468358Z","steps":["trace[1823646642] 'agreement among raft nodes before linearized reading' (duration: 153.660308ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:26.46862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.116991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:52:26.468681Z","caller":"traceutil/trace.go:171","msg":"trace[2070837740] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:599; }","duration":"154.204743ms","start":"2026-04-07T05:52:26.314462Z","end":"2026-04-07T05:52:26.468667Z","steps":["trace[2070837740] 'agreement among raft nodes before linearized reading' (duration: 154.11567ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:26.46869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.277545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:52:26.468748Z","caller":"traceutil/trace.go:171","msg":"trace[635441275] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:599; }","duration":"100.335317ms","start":"2026-04-07T05:52:26.368391Z","end":"2026-04-07T05:52:26.468726Z","steps":["trace[635441275] 'agreement among raft nodes before linearized reading' (duration: 100.264006ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:26.468863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.656127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:52:26.468982Z","caller":"traceutil/trace.go:171","msg":"trace[1711403981] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:599; }","duration":"182.823872ms","start":"2026-04-07T05:52:26.286144Z","end":"2026-04-07T05:52:26.468968Z","steps":["trace[1711403981] 'agreement among raft nodes before linearized reading' (duration: 182.680618ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:26.46911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.49894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:52:26.469176Z","caller":"traceutil/trace.go:171","msg":"trace[1090223776] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:599; }","duration":"101.578791ms","start":"2026-04-07T05:52:26.367581Z","end":"2026-04-07T05:52:26.469159Z","steps":["trace[1090223776] 'agreement among raft nodes before linearized reading' (duration: 101.479508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:26.469196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.273084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:52:26.469254Z","caller":"traceutil/trace.go:171","msg":"trace[537353901] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:599; }","duration":"183.359856ms","start":"2026-04-07T05:52:26.28588Z","end":"2026-04-07T05:52:26.46924Z","steps":["trace[537353901] 'agreement among raft nodes before linearized reading' (duration: 183.275284ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:26.469366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.798617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:52:26.469407Z","caller":"traceutil/trace.go:171","msg":"trace[1924975496] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:599; }","duration":"101.842019ms","start":"2026-04-07T05:52:26.367553Z","end":"2026-04-07T05:52:26.469395Z","steps":["trace[1924975496] 'agreement among raft nodes before linearized reading' (duration: 101.771597ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:26.469443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.412914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:52:26.469503Z","caller":"traceutil/trace.go:171","msg":"trace[534618383] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:599; }","duration":"214.489035ms","start":"2026-04-07T05:52:26.254996Z","end":"2026-04-07T05:52:26.469485Z","steps":["trace[534618383] 'agreement among raft nodes before linearized reading' (duration: 214.401733ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:26.468628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.225098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:52:26.470068Z","caller":"traceutil/trace.go:171","msg":"trace[702272555] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:599; }","duration":"215.555905ms","start":"2026-04-07T05:52:26.254383Z","end":"2026-04-07T05:52:26.469939Z","steps":["trace[702272555] 'agreement among raft nodes before linearized reading' (duration: 214.191117ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:29.430149Z","caller":"traceutil/trace.go:171","msg":"trace[1820421143] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"106.328862ms","start":"2026-04-07T05:52:29.323785Z","end":"2026-04-07T05:52:29.430114Z","steps":["trace[1820421143] 'process raft request' (duration: 106.130666ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:29.616631Z","caller":"traceutil/trace.go:171","msg":"trace[1514022228] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"172.968991ms","start":"2026-04-07T05:52:29.443636Z","end":"2026-04-07T05:52:29.616605Z","steps":["trace[1514022228] 'process raft request' (duration: 172.780735ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:29.625223Z","caller":"traceutil/trace.go:171","msg":"trace[40593763] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"152.632311ms","start":"2026-04-07T05:52:29.47255Z","end":"2026-04-07T05:52:29.625182Z","steps":["trace[40593763] 'process raft request' (duration: 152.338382ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:39.021741Z","caller":"traceutil/trace.go:171","msg":"trace[1841356662] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"235.082314ms","start":"2026-04-07T05:52:38.786629Z","end":"2026-04-07T05:52:39.021711Z","steps":["trace[1841356662] 'process raft request' (duration: 234.910729ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:05.379594Z","caller":"traceutil/trace.go:171","msg":"trace[1956007485] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"185.658101ms","start":"2026-04-07T05:53:05.193912Z","end":"2026-04-07T05:53:05.37957Z","steps":["trace[1956007485] 'process raft request' (duration: 185.422214ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:05.658289Z","caller":"traceutil/trace.go:171","msg":"trace[232271338] transaction","detail":"{read_only:false; response_revision:1125; number_of_response:1; }","duration":"274.620924ms","start":"2026-04-07T05:53:05.383638Z","end":"2026-04-07T05:53:05.658259Z","steps":["trace[232271338] 'process raft request' (duration: 273.137503ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:05.664414Z","caller":"traceutil/trace.go:171","msg":"trace[1458793371] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"280.104714ms","start":"2026-04-07T05:53:05.384283Z","end":"2026-04-07T05:53:05.664388Z","steps":["trace[1458793371] 'process raft request' (duration: 279.94031ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:05.664924Z","caller":"traceutil/trace.go:171","msg":"trace[1250678934] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"280.583808ms","start":"2026-04-07T05:53:05.384317Z","end":"2026-04-07T05:53:05.6649Z","steps":["trace[1250678934] 'process raft request' (duration: 280.021392ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:05.66499Z","caller":"traceutil/trace.go:171","msg":"trace[1133772356] transaction","detail":"{read_only:false; response_revision:1129; number_of_response:1; }","duration":"189.62321ms","start":"2026-04-07T05:53:05.475331Z","end":"2026-04-07T05:53:05.664954Z","steps":["trace[1133772356] 'process raft request' (duration: 189.558527ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:05.665046Z","caller":"traceutil/trace.go:171","msg":"trace[1693982055] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"280.682731ms","start":"2026-04-07T05:53:05.384331Z","end":"2026-04-07T05:53:05.665014Z","steps":["trace[1693982055] 'process raft request' (duration: 280.335521ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:27.655117Z","caller":"traceutil/trace.go:171","msg":"trace[744666356] transaction","detail":"{read_only:false; response_revision:1380; number_of_response:1; }","duration":"150.726143ms","start":"2026-04-07T05:53:27.504358Z","end":"2026-04-07T05:53:27.655085Z","steps":["trace[744666356] 'process raft request' (duration: 150.562198ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:53:50.968077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.281946ms","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-07T05:53:50.968199Z","caller":"traceutil/trace.go:171","msg":"trace[1011200244] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1778; }","duration":"148.471201ms","start":"2026-04-07T05:53:50.819702Z","end":"2026-04-07T05:53:50.968173Z","steps":["trace[1011200244] 'range keys from in-memory index tree' (duration: 148.058789ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:53:52.159694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.756808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:53:52.159768Z","caller":"traceutil/trace.go:171","msg":"trace[1819152995] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1779; }","duration":"468.877451ms","start":"2026-04-07T05:53:51.690874Z","end":"2026-04-07T05:53:52.159752Z","steps":["trace[1819152995] 'range keys from in-memory index tree' (duration: 468.634485ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:53:52.159757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.67914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:53:52.159852Z","caller":"traceutil/trace.go:171","msg":"trace[1980224741] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:1779; }","duration":"721.870866ms","start":"2026-04-07T05:53:51.437961Z","end":"2026-04-07T05:53:52.159832Z","steps":["trace[1980224741] 'count revisions from in-memory index tree' (duration: 721.080723ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:53:52.159936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.594865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ee86429d-c753-49ea-b86b-c5629e352e2d\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-04-07T05:53:52.159912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.647382ms","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-07T05:53:52.159994Z","caller":"traceutil/trace.go:171","msg":"trace[2093472833] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ee86429d-c753-49ea-b86b-c5629e352e2d; range_end:; response_count:1; response_revision:1779; }","duration":"562.680638ms","start":"2026-04-07T05:53:51.597299Z","end":"2026-04-07T05:53:52.159979Z","steps":["trace[2093472833] 'range keys from in-memory index tree' (duration: 562.449742ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:53:52.160023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:53:51.597282Z","time spent":"562.735069ms","remote":"127.0.0.1:53158","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-ee86429d-c753-49ea-b86b-c5629e352e2d\" "} {"level":"info","ts":"2026-04-07T05:53:52.160026Z","caller":"traceutil/trace.go:171","msg":"trace[1254262124] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1779; }","duration":"452.794536ms","start":"2026-04-07T05:53:51.707206Z","end":"2026-04-07T05:53:52.16Z","steps":["trace[1254262124] 'range keys from in-memory index tree' (duration: 452.476857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:53:52.160028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.234201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-07T05:53:52.159813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.734909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T05:53:52.160114Z","caller":"traceutil/trace.go:171","msg":"trace[13693764] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1779; }","duration":"797.363596ms","start":"2026-04-07T05:53:51.362733Z","end":"2026-04-07T05:53:52.160097Z","steps":["trace[13693764] 'count revisions from in-memory index tree' (duration: 797.14248ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:52.160139Z","caller":"traceutil/trace.go:171","msg":"trace[497631713] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1779; }","duration":"658.139031ms","start":"2026-04-07T05:53:51.501976Z","end":"2026-04-07T05:53:52.160115Z","steps":["trace[497631713] 'count revisions from in-memory index tree' (duration: 657.597596ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:53:52.159938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:53:51.437938Z","time spent":"721.979097ms","remote":"127.0.0.1:40448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-07T05:53:52.160171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:53:51.362683Z","time spent":"797.472349ms","remote":"127.0.0.1:53308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":23,"response size":30,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"warn","ts":"2026-04-07T05:53:52.160196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:53:51.501952Z","time spent":"658.230413ms","remote":"127.0.0.1:53232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":30,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"warn","ts":"2026-04-07T05:53:52.160076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.011987ms","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":"warn","ts":"2026-04-07T05:53:52.160231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"791.943945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ee86429d-c753-49ea-b86b-c5629e352e2d\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-07T05:53:52.160296Z","caller":"traceutil/trace.go:171","msg":"trace[1132959512] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1779; }","duration":"369.245553ms","start":"2026-04-07T05:53:51.791032Z","end":"2026-04-07T05:53:52.160277Z","steps":["trace[1132959512] 'range keys from in-memory index tree' (duration: 368.922644ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:52.16031Z","caller":"traceutil/trace.go:171","msg":"trace[1298093036] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ee86429d-c753-49ea-b86b-c5629e352e2d; range_end:; response_count:1; response_revision:1779; }","duration":"792.065129ms","start":"2026-04-07T05:53:51.368228Z","end":"2026-04-07T05:53:52.160293Z","steps":["trace[1298093036] 'range keys from in-memory index tree' (duration: 791.491054ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:53:52.16037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:53:51.791019Z","time spent":"369.335305ms","remote":"127.0.0.1:53238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-07T05:53:52.160379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:53:51.368206Z","time spent":"792.158732ms","remote":"127.0.0.1:53158","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-ee86429d-c753-49ea-b86b-c5629e352e2d\" "} {"level":"warn","ts":"2026-04-07T05:53:52.160081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:53:51.707193Z","time spent":"452.874148ms","remote":"127.0.0.1:60430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-07T05:53:52.160515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.069501ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"warn","ts":"2026-04-07T05:53:52.159809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:53:51.690856Z","time spent":"468.940302ms","remote":"127.0.0.1:52958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-07T05:53:52.160678Z","caller":"traceutil/trace.go:171","msg":"trace[814090889] linearizableReadLoop","detail":"{readStateIndex:1852; appliedIndex:1850; }","duration":"222.117229ms","start":"2026-04-07T05:53:51.938551Z","end":"2026-04-07T05:53:52.160668Z","steps":["trace[814090889] 'read index received' (duration: 59.901978ms)","trace[814090889] 'applied index is now lower than readState.Index' (duration: 162.214591ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:53:52.160728Z","caller":"traceutil/trace.go:171","msg":"trace[1869102469] transaction","detail":"{read_only:false; response_revision:1781; number_of_response:1; }","duration":"285.518375ms","start":"2026-04-07T05:53:51.875195Z","end":"2026-04-07T05:53:52.160713Z","steps":["trace[1869102469] 'process raft request' (duration: 285.377941ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:52.160756Z","caller":"traceutil/trace.go:171","msg":"trace[1712343190] transaction","detail":"{read_only:false; response_revision:1780; number_of_response:1; }","duration":"317.672725ms","start":"2026-04-07T05:53:51.843042Z","end":"2026-04-07T05:53:52.160714Z","steps":["trace[1712343190] 'process raft request' (duration: 75.228933ms)","trace[1712343190] 'compare' (duration: 241.718122ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:53:52.161212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:53:51.84295Z","time spent":"318.17996ms","remote":"127.0.0.1:53238","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-07T05:53:52.161248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.046459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-07T05:53:52.161288Z","caller":"traceutil/trace.go:171","msg":"trace[1945184612] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1781; }","duration":"196.095659ms","start":"2026-04-07T05:53:51.965176Z","end":"2026-04-07T05:53:52.161272Z","steps":["trace[1945184612] 'agreement among raft nodes before linearized reading' (duration: 195.926954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:53:52.16132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.718039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-07T05:53:52.160888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.347285ms","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-07T05:53:52.161393Z","caller":"traceutil/trace.go:171","msg":"trace[2107230082] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1781; }","duration":"222.922191ms","start":"2026-04-07T05:53:51.938456Z","end":"2026-04-07T05:53:52.161378Z","steps":["trace[2107230082] 'agreement among raft nodes before linearized reading' (duration: 222.345966ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:53:52.161421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.532926ms","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-07T05:53:52.161424Z","caller":"traceutil/trace.go:171","msg":"trace[536878377] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1781; }","duration":"156.860173ms","start":"2026-04-07T05:53:52.004537Z","end":"2026-04-07T05:53:52.161397Z","steps":["trace[536878377] 'agreement among raft nodes before linearized reading' (duration: 156.588936ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:53:52.16143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.336224ms","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-07T05:53:52.161441Z","caller":"traceutil/trace.go:171","msg":"trace[1971322996] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1781; }","duration":"185.579718ms","start":"2026-04-07T05:53:51.975854Z","end":"2026-04-07T05:53:52.161434Z","steps":["trace[1971322996] 'agreement among raft nodes before linearized reading' (duration: 185.522816ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:52.161474Z","caller":"traceutil/trace.go:171","msg":"trace[1189185868] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1781; }","duration":"175.396717ms","start":"2026-04-07T05:53:51.986063Z","end":"2026-04-07T05:53:52.161459Z","steps":["trace[1189185868] 'agreement among raft nodes before linearized reading' (duration: 175.183831ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:52.663302Z","caller":"traceutil/trace.go:171","msg":"trace[81934631] transaction","detail":"{read_only:false; response_revision:1782; number_of_response:1; }","duration":"498.375427ms","start":"2026-04-07T05:53:52.164899Z","end":"2026-04-07T05:53:52.663274Z","steps":["trace[81934631] 'process raft request' (duration: 497.911475ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:53:52.663452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:53:52.164864Z","time spent":"498.506442ms","remote":"127.0.0.1:53238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:53:52.925657Z","caller":"traceutil/trace.go:171","msg":"trace[514505135] transaction","detail":"{read_only:false; response_revision:1783; number_of_response:1; }","duration":"759.037114ms","start":"2026-04-07T05:53:52.166593Z","end":"2026-04-07T05:53:52.92563Z","steps":["trace[514505135] 'process raft request' (duration: 758.821308ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:53:52.925821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:53:52.16656Z","time spent":"759.180918ms","remote":"127.0.0.1:53238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:53:52.926007Z","caller":"traceutil/trace.go:171","msg":"trace[51386317] transaction","detail":"{read_only:false; response_revision:1784; number_of_response:1; }","duration":"759.314252ms","start":"2026-04-07T05:53:52.166676Z","end":"2026-04-07T05:53:52.92599Z","steps":["trace[51386317] 'process raft request' (duration: 758.90301ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:53:52.92611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:53:52.166656Z","time spent":"759.408485ms","remote":"127.0.0.1:53238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:53:52.926359Z","caller":"traceutil/trace.go:171","msg":"trace[1706900656] linearizableReadLoop","detail":"{readStateIndex:1858; appliedIndex:1852; }","duration":"742.273ms","start":"2026-04-07T05:53:52.184047Z","end":"2026-04-07T05:53:52.92632Z","steps":["trace[1706900656] 'read index received' (duration: 478.860057ms)","trace[1706900656] 'applied index is now lower than readState.Index' (duration: 263.411353ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:53:52.926472Z","caller":"traceutil/trace.go:171","msg":"trace[2130740688] transaction","detail":"{read_only:false; response_revision:1786; number_of_response:1; }","duration":"758.754046ms","start":"2026-04-07T05:53:52.167699Z","end":"2026-04-07T05:53:52.926453Z","steps":["trace[2130740688] 'process raft request' (duration: 758.442557ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:52.92652Z","caller":"traceutil/trace.go:171","msg":"trace[1777150123] transaction","detail":"{read_only:false; response_revision:1785; number_of_response:1; }","duration":"759.473216ms","start":"2026-04-07T05:53:52.167032Z","end":"2026-04-07T05:53:52.926505Z","steps":["trace[1777150123] 'process raft request' (duration: 758.87919ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:53:52.926588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:53:52.167015Z","time spent":"759.539028ms","remote":"127.0.0.1:53238","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-07T05:53:52.926574Z","caller":"traceutil/trace.go:171","msg":"trace[820339213] transaction","detail":"{read_only:false; response_revision:1787; number_of_response:1; }","duration":"758.454758ms","start":"2026-04-07T05:53:52.168091Z","end":"2026-04-07T05:53:52.926545Z","steps":["trace[820339213] 'process raft request' (duration: 758.16426ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:53:52.92666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"742.59481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:553"} {"level":"info","ts":"2026-04-07T05:53:52.926781Z","caller":"traceutil/trace.go:171","msg":"trace[72324393] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1787; }","duration":"742.749043ms","start":"2026-04-07T05:53:52.184005Z","end":"2026-04-07T05:53:52.926754Z","steps":["trace[72324393] 'agreement among raft nodes before linearized reading' (duration: 742.470285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:53:52.926786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:53:52.168066Z","time spent":"758.580552ms","remote":"127.0.0.1:53238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:53:52.926748Z","caller":"traceutil/trace.go:171","msg":"trace[349443939] transaction","detail":"{read_only:false; response_revision:1788; number_of_response:1; }","duration":"157.531261ms","start":"2026-04-07T05:53:52.769121Z","end":"2026-04-07T05:53:52.926652Z","steps":["trace[349443939] 'process raft request' (duration: 157.302405ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:53:52.926836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:53:52.183986Z","time spent":"742.835076ms","remote":"127.0.0.1:53238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":576,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-07T05:53:52.926663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:53:52.167691Z","time spent":"758.862449ms","remote":"127.0.0.1:53158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:54:36.478075Z","caller":"traceutil/trace.go:171","msg":"trace[357303871] transaction","detail":"{read_only:false; response_revision:2079; number_of_response:1; }","duration":"119.405174ms","start":"2026-04-07T05:54:36.35864Z","end":"2026-04-07T05:54:36.478045Z","steps":["trace[357303871] 'process raft request' (duration: 119.197188ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:42.23641Z","caller":"traceutil/trace.go:171","msg":"trace[846672055] transaction","detail":"{read_only:false; response_revision:2109; number_of_response:1; }","duration":"262.601395ms","start":"2026-04-07T05:54:41.973775Z","end":"2026-04-07T05:54:42.236376Z","steps":["trace[846672055] 'process raft request' (duration: 262.395919ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:42.901571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.188263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:54:42.901639Z","caller":"traceutil/trace.go:171","msg":"trace[1580673558] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2111; }","duration":"214.309306ms","start":"2026-04-07T05:54:42.687313Z","end":"2026-04-07T05:54:42.901622Z","steps":["trace[1580673558] 'range keys from in-memory index tree' (duration: 214.0914ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:31.415189Z","caller":"traceutil/trace.go:171","msg":"trace[814947208] transaction","detail":"{read_only:false; response_revision:2548; number_of_response:1; }","duration":"218.107515ms","start":"2026-04-07T05:55:31.197058Z","end":"2026-04-07T05:55:31.415165Z","steps":["trace[814947208] 'process raft request' (duration: 217.976751ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:31.520646Z","caller":"traceutil/trace.go:171","msg":"trace[650821612] transaction","detail":"{read_only:false; response_revision:2549; number_of_response:1; }","duration":"166.09058ms","start":"2026-04-07T05:55:31.354522Z","end":"2026-04-07T05:55:31.520613Z","steps":["trace[650821612] 'process raft request' (duration: 155.999172ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:31.520642Z","caller":"traceutil/trace.go:171","msg":"trace[2085408239] linearizableReadLoop","detail":"{readStateIndex:2650; appliedIndex:2648; }","duration":"118.501468ms","start":"2026-04-07T05:55:31.402102Z","end":"2026-04-07T05:55:31.520604Z","steps":["trace[2085408239] 'read index received' (duration: 12.878126ms)","trace[2085408239] 'applied index is now lower than readState.Index' (duration: 105.621552ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:55:31.52106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.937209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1986"} {"level":"info","ts":"2026-04-07T05:55:31.521148Z","caller":"traceutil/trace.go:171","msg":"trace[1750505075] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2549; }","duration":"119.071503ms","start":"2026-04-07T05:55:31.402056Z","end":"2026-04-07T05:55:31.521128Z","steps":["trace[1750505075] 'agreement among raft nodes before linearized reading' (duration: 118.632661ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:56:04.981169Z","caller":"traceutil/trace.go:171","msg":"trace[545034949] transaction","detail":"{read_only:false; response_revision:2752; number_of_response:1; }","duration":"138.764246ms","start":"2026-04-07T05:56:04.842379Z","end":"2026-04-07T05:56:04.981143Z","steps":["trace[545034949] 'process raft request' (duration: 138.585281ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:56:04.991731Z","caller":"traceutil/trace.go:171","msg":"trace[87380283] linearizableReadLoop","detail":"{readStateIndex:2861; appliedIndex:2859; }","duration":"123.100864ms","start":"2026-04-07T05:56:04.868612Z","end":"2026-04-07T05:56:04.991713Z","steps":["trace[87380283] 'read index received' (duration: 112.43095ms)","trace[87380283] 'applied index is now lower than readState.Index' (duration: 10.669264ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:56:04.991857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.227367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:56:04.991818Z","caller":"traceutil/trace.go:171","msg":"trace[1410186757] transaction","detail":"{read_only:false; response_revision:2753; number_of_response:1; }","duration":"145.638425ms","start":"2026-04-07T05:56:04.84614Z","end":"2026-04-07T05:56:04.991778Z","steps":["trace[1410186757] 'process raft request' (duration: 145.485211ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:56:04.991901Z","caller":"traceutil/trace.go:171","msg":"trace[1393824672] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:2753; }","duration":"123.3202ms","start":"2026-04-07T05:56:04.868567Z","end":"2026-04-07T05:56:04.991887Z","steps":["trace[1393824672] 'agreement among raft nodes before linearized reading' (duration: 123.239568ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:58:30.78678Z","caller":"traceutil/trace.go:171","msg":"trace[1253953125] linearizableReadLoop","detail":"{readStateIndex:3869; appliedIndex:3868; }","duration":"101.209252ms","start":"2026-04-07T05:58:30.685545Z","end":"2026-04-07T05:58:30.786754Z","steps":["trace[1253953125] 'read index received' (duration: 101.020296ms)","trace[1253953125] 'applied index is now lower than readState.Index' (duration: 187.855µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:58:30.786908Z","caller":"traceutil/trace.go:171","msg":"trace[1876401768] transaction","detail":"{read_only:false; response_revision:3724; number_of_response:1; }","duration":"114.554749ms","start":"2026-04-07T05:58:30.672342Z","end":"2026-04-07T05:58:30.786897Z","steps":["trace[1876401768] 'process raft request' (duration: 114.22466ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:58:30.787109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.546081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:58:30.787213Z","caller":"traceutil/trace.go:171","msg":"trace[966515438] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3724; }","duration":"101.695715ms","start":"2026-04-07T05:58:30.685489Z","end":"2026-04-07T05:58:30.787184Z","steps":["trace[966515438] 'agreement among raft nodes before linearized reading' (duration: 101.509ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:58:36.328655Z","caller":"traceutil/trace.go:171","msg":"trace[840224256] transaction","detail":"{read_only:false; response_revision:3749; number_of_response:1; }","duration":"140.097611ms","start":"2026-04-07T05:58:36.188531Z","end":"2026-04-07T05:58:36.328628Z","steps":["trace[840224256] 'process raft request' (duration: 139.882355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:59:57.156853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.336089ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T05:59:57.156965Z","caller":"traceutil/trace.go:171","msg":"trace[1621835405] transaction","detail":"{read_only:false; response_revision:4783; number_of_response:1; }","duration":"316.839084ms","start":"2026-04-07T05:59:56.840111Z","end":"2026-04-07T05:59:57.15695Z","steps":["trace[1621835405] 'process raft request' (duration: 133.33509ms)","trace[1621835405] 'compare' (duration: 183.219306ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:59:57.157012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:59:56.840097Z","time spent":"316.893855ms","remote":"127.0.0.1:53238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:59:59.015702Z","caller":"traceutil/trace.go:171","msg":"trace[792972309] transaction","detail":"{read_only:false; response_revision:4906; number_of_response:1; }","duration":"201.021423ms","start":"2026-04-07T05:59:58.814648Z","end":"2026-04-07T05:59:59.015669Z","steps":["trace[792972309] 'process raft request' (duration: 166.408106ms)","trace[792972309] 'compare' (duration: 34.485204ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:59:59.097885Z","caller":"traceutil/trace.go:171","msg":"trace[1989291683] linearizableReadLoop","detail":"{readStateIndex:5095; appliedIndex:5093; }","duration":"281.277881ms","start":"2026-04-07T05:59:58.816579Z","end":"2026-04-07T05:59:59.097857Z","steps":["trace[1989291683] 'read index received' (duration: 164.482814ms)","trace[1989291683] 'applied index is now lower than readState.Index' (duration: 116.793917ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:59:59.098014Z","caller":"traceutil/trace.go:171","msg":"trace[51376737] transaction","detail":"{read_only:false; response_revision:4907; number_of_response:1; }","duration":"282.308698ms","start":"2026-04-07T05:59:58.81567Z","end":"2026-04-07T05:59:59.097979Z","steps":["trace[51376737] 'process raft request' (duration: 282.035291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:59:59.098167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.567629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-04-07T05:59:59.098211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.736034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-07T05:59:59.098218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.476495ms","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-07T05:59:59.09824Z","caller":"traceutil/trace.go:171","msg":"trace[1838488362] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4907; }","duration":"281.699462ms","start":"2026-04-07T05:59:58.816519Z","end":"2026-04-07T05:59:59.098218Z","steps":["trace[1838488362] 'agreement among raft nodes before linearized reading' (duration: 281.460945ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:59:59.098263Z","caller":"traceutil/trace.go:171","msg":"trace[547968842] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4907; }","duration":"277.836507ms","start":"2026-04-07T05:59:58.820412Z","end":"2026-04-07T05:59:59.098249Z","steps":["trace[547968842] 'agreement among raft nodes before linearized reading' (duration: 277.693643ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:59:59.098276Z","caller":"traceutil/trace.go:171","msg":"trace[317098854] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4907; }","duration":"281.569659ms","start":"2026-04-07T05:59:58.816691Z","end":"2026-04-07T05:59:59.098261Z","steps":["trace[317098854] 'agreement among raft nodes before linearized reading' (duration: 281.368824ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:59:59.206232Z","caller":"traceutil/trace.go:171","msg":"trace[1967302471] transaction","detail":"{read_only:false; response_revision:4908; number_of_response:1; }","duration":"103.715619ms","start":"2026-04-07T05:59:59.102495Z","end":"2026-04-07T05:59:59.206211Z","steps":["trace[1967302471] 'process raft request' (duration: 88.878314ms)","trace[1967302471] 'compare' (duration: 14.736452ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:59:59.283877Z","caller":"traceutil/trace.go:171","msg":"trace[636027985] linearizableReadLoop","detail":"{readStateIndex:5098; appliedIndex:5095; }","duration":"173.612043ms","start":"2026-04-07T05:59:59.11024Z","end":"2026-04-07T05:59:59.283852Z","steps":["trace[636027985] 'read index received' (duration: 81.148282ms)","trace[636027985] 'applied index is now lower than readState.Index' (duration: 92.462371ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:59:59.284182Z","caller":"traceutil/trace.go:171","msg":"trace[812942529] transaction","detail":"{read_only:false; response_revision:4909; number_of_response:1; }","duration":"181.587611ms","start":"2026-04-07T05:59:59.10258Z","end":"2026-04-07T05:59:59.284168Z","steps":["trace[812942529] 'process raft request' (duration: 181.010996ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:59:59.284317Z","caller":"traceutil/trace.go:171","msg":"trace[766800746] transaction","detail":"{read_only:false; response_revision:4910; number_of_response:1; }","duration":"180.597345ms","start":"2026-04-07T05:59:59.103708Z","end":"2026-04-07T05:59:59.284306Z","steps":["trace[766800746] 'process raft request' (duration: 180.023739ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:59:59.284485Z","caller":"traceutil/trace.go:171","msg":"trace[448333775] transaction","detail":"{read_only:false; response_revision:4911; number_of_response:1; }","duration":"100.539472ms","start":"2026-04-07T05:59:59.183937Z","end":"2026-04-07T05:59:59.284476Z","steps":["trace[448333775] 'process raft request' (duration: 99.851144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:59:59.28478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.440986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T05:59:59.284867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.344586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-07T05:59:59.284906Z","caller":"traceutil/trace.go:171","msg":"trace[115573128] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:4911; }","duration":"174.664232ms","start":"2026-04-07T05:59:59.110216Z","end":"2026-04-07T05:59:59.284881Z","steps":["trace[115573128] 'agreement among raft nodes before linearized reading' (duration: 174.391504ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:59:59.284949Z","caller":"traceutil/trace.go:171","msg":"trace[21430873] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4911; }","duration":"123.455369ms","start":"2026-04-07T05:59:59.161474Z","end":"2026-04-07T05:59:59.284929Z","steps":["trace[21430873] 'agreement among raft nodes before linearized reading' (duration: 123.209093ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:00.807507Z","caller":"traceutil/trace.go:171","msg":"trace[1821387129] transaction","detail":"{read_only:false; response_revision:4939; number_of_response:1; }","duration":"125.348501ms","start":"2026-04-07T06:00:00.68212Z","end":"2026-04-07T06:00:00.807469Z","steps":["trace[1821387129] 'process raft request' (duration: 125.067563ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:02.952023Z","caller":"traceutil/trace.go:171","msg":"trace[1109793731] linearizableReadLoop","detail":"{readStateIndex:5187; appliedIndex:5184; }","duration":"124.013165ms","start":"2026-04-07T06:00:02.827978Z","end":"2026-04-07T06:00:02.951991Z","steps":["trace[1109793731] 'read index received' (duration: 19.418522ms)","trace[1109793731] 'applied index is now lower than readState.Index' (duration: 104.593533ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:00:02.952218Z","caller":"traceutil/trace.go:171","msg":"trace[978006817] transaction","detail":"{read_only:false; response_revision:4996; number_of_response:1; }","duration":"124.943221ms","start":"2026-04-07T06:00:02.827241Z","end":"2026-04-07T06:00:02.952184Z","steps":["trace[978006817] 'process raft request' (duration: 124.656823ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:02.952377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.369065ms","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-07T06:00:02.952428Z","caller":"traceutil/trace.go:171","msg":"trace[1672098428] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4996; }","duration":"124.467057ms","start":"2026-04-07T06:00:02.827946Z","end":"2026-04-07T06:00:02.952413Z","steps":["trace[1672098428] 'agreement among raft nodes before linearized reading' (duration: 124.230701ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:02.952753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.248833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T06:00:02.952793Z","caller":"traceutil/trace.go:171","msg":"trace[1246989912] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:4996; }","duration":"108.314235ms","start":"2026-04-07T06:00:02.844468Z","end":"2026-04-07T06:00:02.952782Z","steps":["trace[1246989912] 'agreement among raft nodes before linearized reading' (duration: 108.249274ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:02.952975Z","caller":"traceutil/trace.go:171","msg":"trace[443000170] transaction","detail":"{read_only:false; response_revision:4995; number_of_response:1; }","duration":"140.249439ms","start":"2026-04-07T06:00:02.812712Z","end":"2026-04-07T06:00:02.952961Z","steps":["trace[443000170] 'process raft request' (duration: 136.085535ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:02.953085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.896317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-04-07T06:00:02.953123Z","caller":"traceutil/trace.go:171","msg":"trace[1882805803] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:4996; }","duration":"102.958759ms","start":"2026-04-07T06:00:02.850152Z","end":"2026-04-07T06:00:02.953111Z","steps":["trace[1882805803] 'agreement among raft nodes before linearized reading' (duration: 102.856706ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:18.034227Z","caller":"traceutil/trace.go:171","msg":"trace[1790177102] transaction","detail":"{read_only:false; response_revision:5252; number_of_response:1; }","duration":"131.410218ms","start":"2026-04-07T06:00:17.902789Z","end":"2026-04-07T06:00:18.034199Z","steps":["trace[1790177102] 'process raft request' (duration: 131.280093ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:18.798893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.323288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:00:18.798987Z","caller":"traceutil/trace.go:171","msg":"trace[871066115] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5257; }","duration":"111.470241ms","start":"2026-04-07T06:00:18.687496Z","end":"2026-04-07T06:00:18.798966Z","steps":["trace[871066115] 'range keys from in-memory index tree' (duration: 111.245026ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:18.799465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.916203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-737ecefe-448b-4313-971c-9cd549535bd9\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-07T06:00:18.799519Z","caller":"traceutil/trace.go:171","msg":"trace[1666766262] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-737ecefe-448b-4313-971c-9cd549535bd9; range_end:; response_count:1; response_revision:5257; }","duration":"139.019346ms","start":"2026-04-07T06:00:18.660488Z","end":"2026-04-07T06:00:18.799508Z","steps":["trace[1666766262] 'range keys from in-memory index tree' (duration: 138.721638ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:21.177062Z","caller":"traceutil/trace.go:171","msg":"trace[1483018149] transaction","detail":"{read_only:false; response_revision:5285; number_of_response:1; }","duration":"149.997527ms","start":"2026-04-07T06:00:21.027025Z","end":"2026-04-07T06:00:21.177023Z","steps":["trace[1483018149] 'process raft request' (duration: 67.95298ms)","trace[1483018149] 'compare' (duration: 81.476841ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T06:00:21.177072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.008393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-07T06:00:21.177417Z","caller":"traceutil/trace.go:171","msg":"trace[1385945453] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:5284; }","duration":"220.431455ms","start":"2026-04-07T06:00:20.956969Z","end":"2026-04-07T06:00:21.1774Z","steps":["trace[1385945453] 'count revisions from in-memory index tree' (duration: 219.828728ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:35.237659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.662158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:00:35.237776Z","caller":"traceutil/trace.go:171","msg":"trace[2125991473] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5484; }","duration":"549.841883ms","start":"2026-04-07T06:00:34.687914Z","end":"2026-04-07T06:00:35.237756Z","steps":["trace[2125991473] 'range keys from in-memory index tree' (duration: 549.567975ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:35.237819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:00:34.687895Z","time spent":"549.914356ms","remote":"127.0.0.1:52958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T06:00:35.238317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.539518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-zzxfr\" ","response":"range_response_count:1 size:8067"} {"level":"info","ts":"2026-04-07T06:00:35.238352Z","caller":"traceutil/trace.go:171","msg":"trace[2007998851] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-zzxfr; range_end:; response_count:1; response_revision:5484; }","duration":"376.575589ms","start":"2026-04-07T06:00:34.861764Z","end":"2026-04-07T06:00:35.23834Z","steps":["trace[2007998851] 'range keys from in-memory index tree' (duration: 376.344212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:35.238333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.867198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"warn","ts":"2026-04-07T06:00:35.238397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:00:34.861718Z","time spent":"376.671991ms","remote":"127.0.0.1:53158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":8090,"request content":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-zzxfr\" "} {"level":"info","ts":"2026-04-07T06:00:35.238622Z","caller":"traceutil/trace.go:171","msg":"trace[2021702392] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5484; }","duration":"308.040733ms","start":"2026-04-07T06:00:34.930385Z","end":"2026-04-07T06:00:35.238425Z","steps":["trace[2021702392] 'range keys from in-memory index tree' (duration: 307.228751ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:35.238691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:00:34.930363Z","time spent":"308.30954ms","remote":"127.0.0.1:53134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-04-07T06:00:35.479838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.68086ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T06:00:35.480139Z","caller":"traceutil/trace.go:171","msg":"trace[616788752] linearizableReadLoop","detail":"{readStateIndex:5690; appliedIndex:5688; }","duration":"140.051955ms","start":"2026-04-07T06:00:35.340066Z","end":"2026-04-07T06:00:35.480118Z","steps":["trace[616788752] 'read index received' (duration: 10.095787ms)","trace[616788752] 'applied index is now lower than readState.Index' (duration: 129.954968ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:00:35.480188Z","caller":"traceutil/trace.go:171","msg":"trace[2117014369] transaction","detail":"{read_only:false; response_revision:5488; number_of_response:1; }","duration":"147.187779ms","start":"2026-04-07T06:00:35.332969Z","end":"2026-04-07T06:00:35.480157Z","steps":["trace[2117014369] 'process raft request' (duration: 147.072236ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:35.480438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.340233ms","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-07T06:00:35.480533Z","caller":"traceutil/trace.go:171","msg":"trace[2101864501] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5488; }","duration":"140.494406ms","start":"2026-04-07T06:00:35.340017Z","end":"2026-04-07T06:00:35.480511Z","steps":["trace[2101864501] 'agreement among raft nodes before linearized reading' (duration: 140.166247ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:35.480162Z","caller":"traceutil/trace.go:171","msg":"trace[385392968] transaction","detail":"{read_only:false; response_revision:5487; number_of_response:1; }","duration":"150.8104ms","start":"2026-04-07T06:00:35.32931Z","end":"2026-04-07T06:00:35.480121Z","steps":["trace[385392968] 'process raft request' (duration: 20.765069ms)","trace[385392968] 'compare' (duration: 129.521626ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:01:17.390429Z","caller":"traceutil/trace.go:171","msg":"trace[2009406122] transaction","detail":"{read_only:false; response_revision:5849; number_of_response:1; }","duration":"121.060372ms","start":"2026-04-07T06:01:17.26934Z","end":"2026-04-07T06:01:17.3904Z","steps":["trace[2009406122] 'process raft request' (duration: 120.198788ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:01:17.81704Z","caller":"traceutil/trace.go:171","msg":"trace[818586978] linearizableReadLoop","detail":"{readStateIndex:6065; appliedIndex:6063; }","duration":"115.574972ms","start":"2026-04-07T06:01:17.701442Z","end":"2026-04-07T06:01:17.817017Z","steps":["trace[818586978] 'read index received' (duration: 63.456796ms)","trace[818586978] 'applied index is now lower than readState.Index' (duration: 52.116736ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:01:17.817372Z","caller":"traceutil/trace.go:171","msg":"trace[632149674] transaction","detail":"{read_only:false; response_revision:5852; number_of_response:1; }","duration":"116.375694ms","start":"2026-04-07T06:01:17.700979Z","end":"2026-04-07T06:01:17.817355Z","steps":["trace[632149674] 'process raft request' (duration: 115.911302ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:01:17.817918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.435555ms","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-07T06:01:17.818013Z","caller":"traceutil/trace.go:171","msg":"trace[619033555] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5852; }","duration":"116.553209ms","start":"2026-04-07T06:01:17.701438Z","end":"2026-04-07T06:01:17.817991Z","steps":["trace[619033555] 'agreement among raft nodes before linearized reading' (duration: 116.26266ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:01:17.926385Z","caller":"traceutil/trace.go:171","msg":"trace[733500177] linearizableReadLoop","detail":"{readStateIndex:6066; appliedIndex:6065; }","duration":"104.307393ms","start":"2026-04-07T06:01:17.822046Z","end":"2026-04-07T06:01:17.926353Z","steps":["trace[733500177] 'read index received' (duration: 61.332977ms)","trace[733500177] 'applied index is now lower than readState.Index' (duration: 42.973386ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T06:01:17.926621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.545019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:01:17.926687Z","caller":"traceutil/trace.go:171","msg":"trace[2132288096] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5853; }","duration":"104.610662ms","start":"2026-04-07T06:01:17.822042Z","end":"2026-04-07T06:01:17.926653Z","steps":["trace[2132288096] 'agreement among raft nodes before linearized reading' (duration: 104.454867ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:01:17.926772Z","caller":"traceutil/trace.go:171","msg":"trace[800116636] transaction","detail":"{read_only:false; response_revision:5853; number_of_response:1; }","duration":"105.085565ms","start":"2026-04-07T06:01:17.821417Z","end":"2026-04-07T06:01:17.926503Z","steps":["trace[800116636] 'process raft request' (duration: 62.015437ms)","trace[800116636] 'compare' (duration: 42.78484ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:01:17.958154Z","caller":"traceutil/trace.go:171","msg":"trace[1577380114] transaction","detail":"{read_only:false; response_revision:5854; number_of_response:1; }","duration":"135.837826ms","start":"2026-04-07T06:01:17.822295Z","end":"2026-04-07T06:01:17.958133Z","steps":["trace[1577380114] 'process raft request' (duration: 135.670242ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:01:17.958179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.022292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T06:01:17.958512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.207311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-07T06:01:17.958601Z","caller":"traceutil/trace.go:171","msg":"trace[1108973460] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5854; }","duration":"123.316533ms","start":"2026-04-07T06:01:17.83526Z","end":"2026-04-07T06:01:17.958577Z","steps":["trace[1108973460] 'agreement among raft nodes before linearized reading' (duration: 123.141059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:01:17.958599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.516202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-credential-setup\" ","response":"range_response_count:1 size:6159"} {"level":"info","ts":"2026-04-07T06:01:17.958662Z","caller":"traceutil/trace.go:171","msg":"trace[2103126723] range","detail":"{range_begin:/registry/jobs/openstack/keystone-credential-setup; range_end:; response_count:1; response_revision:5854; }","duration":"133.593736ms","start":"2026-04-07T06:01:17.825053Z","end":"2026-04-07T06:01:17.958646Z","steps":["trace[2103126723] 'agreement among raft nodes before linearized reading' (duration: 133.426621ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:01:17.958259Z","caller":"traceutil/trace.go:171","msg":"trace[507359984] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5854; }","duration":"136.144744ms","start":"2026-04-07T06:01:17.822097Z","end":"2026-04-07T06:01:17.958241Z","steps":["trace[507359984] 'agreement among raft nodes before linearized reading' (duration: 136.000941ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:01:47.242191Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2986} {"level":"info","ts":"2026-04-07T06:01:47.319096Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2986,"took":"74.58294ms","hash":3347863017,"current-db-size-bytes":58621952,"current-db-size":"59 MB","current-db-size-in-use-bytes":33902592,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-07T06:01:47.31917Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3347863017,"revision":2986,"compact-revision":-1} {"level":"info","ts":"2026-04-07T06:06:29.745074Z","caller":"traceutil/trace.go:171","msg":"trace[998363139] transaction","detail":"{read_only:false; response_revision:8164; number_of_response:1; }","duration":"386.247227ms","start":"2026-04-07T06:06:29.358786Z","end":"2026-04-07T06:06:29.745033Z","steps":["trace[998363139] 'process raft request' (duration: 385.962719ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:06:29.746241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:06:29.358759Z","time spent":"387.348287ms","remote":"127.0.0.1:53238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T06:06:30.014558Z","caller":"traceutil/trace.go:171","msg":"trace[8878280] linearizableReadLoop","detail":"{readStateIndex:8453; appliedIndex:8451; }","duration":"574.563889ms","start":"2026-04-07T06:06:29.439952Z","end":"2026-04-07T06:06:30.014516Z","steps":["trace[8878280] 'read index received' (duration: 304.858023ms)","trace[8878280] 'applied index is now lower than readState.Index' (duration: 269.704486ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:06:30.014628Z","caller":"traceutil/trace.go:171","msg":"trace[1221326285] transaction","detail":"{read_only:false; response_revision:8165; number_of_response:1; }","duration":"620.755837ms","start":"2026-04-07T06:06:29.39383Z","end":"2026-04-07T06:06:30.014586Z","steps":["trace[1221326285] 'process raft request' (duration: 586.877945ms)","trace[1221326285] 'compare' (duration: 33.685196ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T06:06:30.014864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.892448ms","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-07T06:06:30.014941Z","caller":"traceutil/trace.go:171","msg":"trace[1445780189] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8165; }","duration":"575.029332ms","start":"2026-04-07T06:06:29.439892Z","end":"2026-04-07T06:06:30.014921Z","steps":["trace[1445780189] 'agreement among raft nodes before linearized reading' (duration: 574.760265ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:06:30.014953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.240402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-07T06:06:30.01498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:06:29.439856Z","time spent":"575.116095ms","remote":"127.0.0.1:53238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-07T06:06:30.015025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.600858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-07T06:06:30.0151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.713166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-04-07T06:06:30.015101Z","caller":"traceutil/trace.go:171","msg":"trace[452011876] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8165; }","duration":"568.7106ms","start":"2026-04-07T06:06:29.446372Z","end":"2026-04-07T06:06:30.015083Z","steps":["trace[452011876] 'agreement among raft nodes before linearized reading' (duration: 568.439853ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:06:30.01498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.710924ms","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-07T06:06:30.015162Z","caller":"traceutil/trace.go:171","msg":"trace[116354011] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:8165; }","duration":"230.775698ms","start":"2026-04-07T06:06:29.784369Z","end":"2026-04-07T06:06:30.015145Z","steps":["trace[116354011] 'agreement among raft nodes before linearized reading' (duration: 230.629984ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:06:30.015177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.144399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-04-07T06:06:30.015209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.864454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:06:30.015223Z","caller":"traceutil/trace.go:171","msg":"trace[45992450] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8165; }","duration":"563.234542ms","start":"2026-04-07T06:06:29.451971Z","end":"2026-04-07T06:06:30.015206Z","steps":["trace[45992450] 'agreement among raft nodes before linearized reading' (duration: 563.093147ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:06:30.015264Z","caller":"traceutil/trace.go:171","msg":"trace[372849746] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8165; }","duration":"329.940375ms","start":"2026-04-07T06:06:29.685305Z","end":"2026-04-07T06:06:30.015246Z","steps":["trace[372849746] 'agreement among raft nodes before linearized reading' (duration: 329.879764ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:06:30.015268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:06:29.451948Z","time spent":"563.305853ms","remote":"127.0.0.1:53238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-07T06:06:30.015034Z","caller":"traceutil/trace.go:171","msg":"trace[1253807126] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8165; }","duration":"563.367835ms","start":"2026-04-07T06:06:29.451648Z","end":"2026-04-07T06:06:30.015016Z","steps":["trace[1253807126] 'agreement among raft nodes before linearized reading' (duration: 563.152159ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:06:30.015311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:06:29.685284Z","time spent":"330.019648ms","remote":"127.0.0.1:52958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T06:06:30.015349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:06:29.451629Z","time spent":"563.706634ms","remote":"127.0.0.1:53238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-07T06:06:30.015238Z","caller":"traceutil/trace.go:171","msg":"trace[534425082] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8165; }","duration":"570.976353ms","start":"2026-04-07T06:06:29.444223Z","end":"2026-04-07T06:06:30.0152Z","steps":["trace[534425082] 'agreement among raft nodes before linearized reading' (duration: 570.464748ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:06:30.015101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.862991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"warn","ts":"2026-04-07T06:06:30.015507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:06:29.444212Z","time spent":"571.254739ms","remote":"127.0.0.1:53238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-07T06:06:30.015577Z","caller":"traceutil/trace.go:171","msg":"trace[313296710] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8165; }","duration":"570.387176ms","start":"2026-04-07T06:06:29.44517Z","end":"2026-04-07T06:06:30.015557Z","steps":["trace[313296710] 'agreement among raft nodes before linearized reading' (duration: 569.789689ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:06:30.014953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.358585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-k48kn\" ","response":"range_response_count:1 size:6524"} {"level":"warn","ts":"2026-04-07T06:06:30.015629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:06:29.445139Z","time spent":"570.475078ms","remote":"127.0.0.1:53238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-04-07T06:06:30.015665Z","caller":"traceutil/trace.go:171","msg":"trace[620484645] range","detail":"{range_begin:/registry/pods/openstack/keepalived-k48kn; range_end:; response_count:1; response_revision:8165; }","duration":"346.141136ms","start":"2026-04-07T06:06:29.669515Z","end":"2026-04-07T06:06:30.015656Z","steps":["trace[620484645] 'agreement among raft nodes before linearized reading' (duration: 345.240432ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:06:30.015161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:06:29.446356Z","time spent":"568.796512ms","remote":"127.0.0.1:53238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-07T06:06:30.015698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:06:29.669483Z","time spent":"346.205838ms","remote":"127.0.0.1:53158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6547,"request content":"key:\"/registry/pods/openstack/keepalived-k48kn\" "} {"level":"warn","ts":"2026-04-07T06:06:30.016011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:06:29.393799Z","time spent":"620.961162ms","remote":"127.0.0.1:53238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T06:06:30.875508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.05374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:06:30.875656Z","caller":"traceutil/trace.go:171","msg":"trace[169794169] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8175; }","duration":"190.266336ms","start":"2026-04-07T06:06:30.685353Z","end":"2026-04-07T06:06:30.87562Z","steps":["trace[169794169] 'range keys from in-memory index tree' (duration: 189.957327ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:06:31.602032Z","caller":"traceutil/trace.go:171","msg":"trace[795010696] transaction","detail":"{read_only:false; response_revision:8179; number_of_response:1; }","duration":"148.047458ms","start":"2026-04-07T06:06:31.453945Z","end":"2026-04-07T06:06:31.601992Z","steps":["trace[795010696] 'process raft request' (duration: 130.252504ms)","trace[795010696] 'compare' (duration: 17.601568ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:06:32.256652Z","caller":"traceutil/trace.go:171","msg":"trace[199587605] transaction","detail":"{read_only:false; response_revision:8182; number_of_response:1; }","duration":"155.204682ms","start":"2026-04-07T06:06:32.10142Z","end":"2026-04-07T06:06:32.256624Z","steps":["trace[199587605] 'process raft request' (duration: 152.891549ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:06:32.257029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.765509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-k48kn\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-07T06:06:32.257103Z","caller":"traceutil/trace.go:171","msg":"trace[1727172757] range","detail":"{range_begin:/registry/pods/openstack/keepalived-k48kn; range_end:; response_count:1; response_revision:8182; }","duration":"154.870013ms","start":"2026-04-07T06:06:32.102217Z","end":"2026-04-07T06:06:32.257087Z","steps":["trace[1727172757] 'agreement among raft nodes before linearized reading' (duration: 154.651667ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:06:32.256592Z","caller":"traceutil/trace.go:171","msg":"trace[402071063] linearizableReadLoop","detail":"{readStateIndex:8472; appliedIndex:8471; }","duration":"154.317578ms","start":"2026-04-07T06:06:32.102237Z","end":"2026-04-07T06:06:32.256554Z","steps":["trace[402071063] 'read index received' (duration: 150.424172ms)","trace[402071063] 'applied index is now lower than readState.Index' (duration: 3.891685ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:06:32.260044Z","caller":"traceutil/trace.go:171","msg":"trace[706984435] transaction","detail":"{read_only:false; response_revision:8187; number_of_response:1; }","duration":"155.365697ms","start":"2026-04-07T06:06:32.104652Z","end":"2026-04-07T06:06:32.260018Z","steps":["trace[706984435] 'process raft request' (duration: 155.309145ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:06:32.26031Z","caller":"traceutil/trace.go:171","msg":"trace[1381986611] transaction","detail":"{read_only:false; response_revision:8185; number_of_response:1; }","duration":"156.519758ms","start":"2026-04-07T06:06:32.103772Z","end":"2026-04-07T06:06:32.260292Z","steps":["trace[1381986611] 'process raft request' (duration: 156.078596ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:06:32.260324Z","caller":"traceutil/trace.go:171","msg":"trace[674549613] transaction","detail":"{read_only:false; response_revision:8183; number_of_response:1; }","duration":"157.31491ms","start":"2026-04-07T06:06:32.102991Z","end":"2026-04-07T06:06:32.260306Z","steps":["trace[674549613] 'process raft request' (duration: 156.59846ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:06:32.260362Z","caller":"traceutil/trace.go:171","msg":"trace[2008982217] transaction","detail":"{read_only:false; response_revision:8186; number_of_response:1; }","duration":"156.448146ms","start":"2026-04-07T06:06:32.103899Z","end":"2026-04-07T06:06:32.260348Z","steps":["trace[2008982217] 'process raft request' (duration: 156.009914ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:06:32.260274Z","caller":"traceutil/trace.go:171","msg":"trace[648042151] transaction","detail":"{read_only:false; response_revision:8184; number_of_response:1; }","duration":"156.788255ms","start":"2026-04-07T06:06:32.103434Z","end":"2026-04-07T06:06:32.260222Z","steps":["trace[648042151] 'process raft request' (duration: 156.346063ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:06:47.25017Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6090} {"level":"info","ts":"2026-04-07T06:06:47.344529Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6090,"took":"92.020884ms","hash":2916386064,"current-db-size-bytes":58621952,"current-db-size":"59 MB","current-db-size-in-use-bytes":23416832,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-07T06:06:47.344601Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2916386064,"revision":6090,"compact-revision":2986} {"level":"info","ts":"2026-04-07T06:07:00.817111Z","caller":"traceutil/trace.go:171","msg":"trace[531985181] transaction","detail":"{read_only:false; response_revision:8393; number_of_response:1; }","duration":"101.47259ms","start":"2026-04-07T06:07:00.715611Z","end":"2026-04-07T06:07:00.817083Z","steps":["trace[531985181] 'process raft request' (duration: 101.312737ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:07:11.775112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.832199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-detect-version\" ","response":"range_response_count:1 size:499"} {"level":"info","ts":"2026-04-07T06:07:11.775213Z","caller":"traceutil/trace.go:171","msg":"trace[851198830] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-detect-version; range_end:; response_count:1; response_revision:8482; }","duration":"137.996763ms","start":"2026-04-07T06:07:11.637195Z","end":"2026-04-07T06:07:11.775192Z","steps":["trace[851198830] 'range keys from in-memory index tree' (duration: 137.701075ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:07:11.778304Z","caller":"traceutil/trace.go:171","msg":"trace[1476761903] linearizableReadLoop","detail":"{readStateIndex:8787; appliedIndex:8786; }","duration":"137.060029ms","start":"2026-04-07T06:07:11.641214Z","end":"2026-04-07T06:07:11.778274Z","steps":["trace[1476761903] 'read index received' (duration: 136.892324ms)","trace[1476761903] 'applied index is now lower than readState.Index' (duration: 166.685µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:07:11.778426Z","caller":"traceutil/trace.go:171","msg":"trace[1440798348] transaction","detail":"{read_only:false; response_revision:8483; number_of_response:1; }","duration":"139.748652ms","start":"2026-04-07T06:07:11.638653Z","end":"2026-04-07T06:07:11.778401Z","steps":["trace[1440798348] 'process raft request' (duration: 139.457844ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:07:11.778635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.389608ms","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-07T06:07:11.778755Z","caller":"traceutil/trace.go:171","msg":"trace[1303547736] range","detail":"{range_begin:/registry/jobs/openstack/rook-ceph-detect-version; range_end:; response_count:1; response_revision:8483; }","duration":"137.541861ms","start":"2026-04-07T06:07:11.641192Z","end":"2026-04-07T06:07:11.778734Z","steps":["trace[1303547736] 'agreement among raft nodes before linearized reading' (duration: 137.251423ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:07:11.784005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.499507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-x7v4x\" ","response":"range_response_count:1 size:4633"} {"level":"info","ts":"2026-04-07T06:07:11.784087Z","caller":"traceutil/trace.go:171","msg":"trace[855047481] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-x7v4x; range_end:; response_count:1; response_revision:8484; }","duration":"142.629959ms","start":"2026-04-07T06:07:11.641416Z","end":"2026-04-07T06:07:11.784046Z","steps":["trace[855047481] 'agreement among raft nodes before linearized reading' (duration: 142.457795ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:07:11.967364Z","caller":"traceutil/trace.go:171","msg":"trace[1648048361] linearizableReadLoop","detail":"{readStateIndex:8789; appliedIndex:8788; }","duration":"175.204516ms","start":"2026-04-07T06:07:11.792138Z","end":"2026-04-07T06:07:11.967343Z","steps":["trace[1648048361] 'read index received' (duration: 174.922699ms)","trace[1648048361] 'applied index is now lower than readState.Index' (duration: 280.857µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:07:11.967425Z","caller":"traceutil/trace.go:171","msg":"trace[1118195896] transaction","detail":"{read_only:false; response_revision:8485; number_of_response:1; }","duration":"176.196913ms","start":"2026-04-07T06:07:11.791198Z","end":"2026-04-07T06:07:11.967395Z","steps":["trace[1118195896] 'process raft request' (duration: 176.009308ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:07:11.967554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.395002ms","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-07T06:07:11.967597Z","caller":"traceutil/trace.go:171","msg":"trace[697893630] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-detect-version; range_end:; response_count:1; response_revision:8485; }","duration":"175.484654ms","start":"2026-04-07T06:07:11.792103Z","end":"2026-04-07T06:07:11.967587Z","steps":["trace[697893630] 'agreement among raft nodes before linearized reading' (duration: 175.33146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:07:12.788849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.770209ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T06:07:12.789061Z","caller":"traceutil/trace.go:171","msg":"trace[24080644] transaction","detail":"{read_only:false; response_revision:8496; number_of_response:1; }","duration":"229.611936ms","start":"2026-04-07T06:07:12.55943Z","end":"2026-04-07T06:07:12.789042Z","steps":["trace[24080644] 'process raft request' (duration: 229.542744ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:07:12.789075Z","caller":"traceutil/trace.go:171","msg":"trace[418773624] transaction","detail":"{read_only:false; response_revision:8495; number_of_response:1; }","duration":"229.626386ms","start":"2026-04-07T06:07:12.559414Z","end":"2026-04-07T06:07:12.78904Z","steps":["trace[418773624] 'process raft request' (duration: 120.544238ms)","trace[418773624] 'compare' (duration: 108.595255ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:07:12.794256Z","caller":"traceutil/trace.go:171","msg":"trace[1237280775] transaction","detail":"{read_only:false; response_revision:8497; number_of_response:1; }","duration":"234.518009ms","start":"2026-04-07T06:07:12.559716Z","end":"2026-04-07T06:07:12.794234Z","steps":["trace[1237280775] 'process raft request' (duration: 234.336345ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:07:12.794481Z","caller":"traceutil/trace.go:171","msg":"trace[154126514] linearizableReadLoop","detail":"{readStateIndex:8802; appliedIndex:8798; }","duration":"233.47143ms","start":"2026-04-07T06:07:12.560991Z","end":"2026-04-07T06:07:12.794462Z","steps":["trace[154126514] 'read index received' (duration: 118.958525ms)","trace[154126514] 'applied index is now lower than readState.Index' (duration: 114.511955ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:07:12.794526Z","caller":"traceutil/trace.go:171","msg":"trace[1707461386] transaction","detail":"{read_only:false; response_revision:8498; number_of_response:1; }","duration":"234.111659ms","start":"2026-04-07T06:07:12.560386Z","end":"2026-04-07T06:07:12.794497Z","steps":["trace[1707461386] 'process raft request' (duration: 233.80281ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:07:12.794598Z","caller":"traceutil/trace.go:171","msg":"trace[1542879455] transaction","detail":"{read_only:false; response_revision:8499; number_of_response:1; }","duration":"233.494172ms","start":"2026-04-07T06:07:12.561083Z","end":"2026-04-07T06:07:12.794578Z","steps":["trace[1542879455] 'process raft request' (duration: 233.297837ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:07:12.794915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.900452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228469"} {"level":"info","ts":"2026-04-07T06:07:12.794972Z","caller":"traceutil/trace.go:171","msg":"trace[1271130949] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8499; }","duration":"233.984505ms","start":"2026-04-07T06:07:12.560976Z","end":"2026-04-07T06:07:12.79496Z","steps":["trace[1271130949] 'agreement among raft nodes before linearized reading' (duration: 233.588064ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:07:12.921867Z","caller":"traceutil/trace.go:171","msg":"trace[913385433] linearizableReadLoop","detail":"{readStateIndex:8804; appliedIndex:8803; }","duration":"127.304922ms","start":"2026-04-07T06:07:12.794542Z","end":"2026-04-07T06:07:12.921847Z","steps":["trace[913385433] 'read index received' (duration: 118.639577ms)","trace[913385433] 'applied index is now lower than readState.Index' (duration: 8.664375ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T06:07:12.921996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.187971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:07:12.921991Z","caller":"traceutil/trace.go:171","msg":"trace[890671990] transaction","detail":"{read_only:false; response_revision:8500; number_of_response:1; }","duration":"134.114058ms","start":"2026-04-07T06:07:12.787843Z","end":"2026-04-07T06:07:12.921957Z","steps":["trace[890671990] 'process raft request' (duration: 125.263268ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:07:12.922035Z","caller":"traceutil/trace.go:171","msg":"trace[1954309070] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:8500; }","duration":"291.332314ms","start":"2026-04-07T06:07:12.63069Z","end":"2026-04-07T06:07:12.922023Z","steps":["trace[1954309070] 'agreement among raft nodes before linearized reading' (duration: 291.239012ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:07:12.922165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.176269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5732"} {"level":"info","ts":"2026-04-07T06:07:12.922252Z","caller":"traceutil/trace.go:171","msg":"trace[860530379] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8500; }","duration":"138.316403ms","start":"2026-04-07T06:07:12.783911Z","end":"2026-04-07T06:07:12.922227Z","steps":["trace[860530379] 'agreement among raft nodes before linearized reading' (duration: 138.066346ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:07:13.573052Z","caller":"traceutil/trace.go:171","msg":"trace[1274304753] transaction","detail":"{read_only:false; response_revision:8504; number_of_response:1; }","duration":"175.380992ms","start":"2026-04-07T06:07:13.39764Z","end":"2026-04-07T06:07:13.573021Z","steps":["trace[1274304753] 'process raft request' (duration: 175.251228ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:07:52.055773Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023da.wal"} {"level":"info","ts":"2026-04-07T06:09:27.390037Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39582465ceaa2f67","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-07T06:09:27.39605Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-07T06:09:27.396171Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-07T06:11:47.257224Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8268} {"level":"info","ts":"2026-04-07T06:11:47.353398Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8268,"took":"93.593472ms","hash":640979869,"current-db-size-bytes":58621952,"current-db-size":"59 MB","current-db-size-in-use-bytes":24768512,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-07T06:11:47.353482Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":640979869,"revision":8268,"compact-revision":6090} {"level":"info","ts":"2026-04-07T06:16:47.263164Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10659} {"level":"info","ts":"2026-04-07T06:16:47.340242Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10659,"took":"75.258271ms","hash":3484483299,"current-db-size-bytes":58621952,"current-db-size":"59 MB","current-db-size-in-use-bytes":20287488,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-07T06:16:47.340312Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3484483299,"revision":10659,"compact-revision":8268}