{"level":"warn","ts":"2026-05-11T00:52:50.819273Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-11T00:52:50.819472Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.242: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.242:2380","--initial-cluster=instance=https://199.204.45.242:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.242:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.242: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-05-11T00:52:50.819576Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-11T00:52:50.819593Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.242:2380"]} {"level":"info","ts":"2026-05-11T00:52:50.819624Z","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-05-11T00:52:50.820951Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"]} {"level":"info","ts":"2026-05-11T00:52:50.821237Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.242: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-05-11T00:52:50.826438Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.528136ms"} {"level":"info","ts":"2026-05-11T00:52:50.835455Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b844c110b9783e73","cluster-id":"49dc9693ccd466a9"} {"level":"info","ts":"2026-05-11T00:52:50.835553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=()"} {"level":"info","ts":"2026-05-11T00:52:50.835577Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 0"} {"level":"info","ts":"2026-05-11T00:52:50.835592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b844c110b9783e73 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-11T00:52:50.835602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 1"} {"level":"info","ts":"2026-05-11T00:52:50.835637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"warn","ts":"2026-05-11T00:52:50.842433Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-11T00:52:50.843558Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-11T00:52:50.844412Z","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-05-11T00:52:50.848221Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b844c110b9783e73","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-11T00:52:50.848937Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b844c110b9783e73","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-11T00:52:50.849646Z","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-05-11T00:52:50.851847Z","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-05-11T00:52:50.851954Z","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-05-11T00:52:50.852805Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"info","ts":"2026-05-11T00:52:50.853171Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","added-peer-id":"b844c110b9783e73","added-peer-peer-urls":["https://199.204.45.242:2380"]} {"level":"info","ts":"2026-05-11T00:52:50.854096Z","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-05-11T00:52:50.854271Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-05-11T00:52:50.854316Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-05-11T00:52:50.854543Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b844c110b9783e73","initial-advertise-peer-urls":["https://199.204.45.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-11T00:52:50.854579Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-11T00:52:51.736126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 is starting a new election at term 1"} {"level":"info","ts":"2026-05-11T00:52:51.736185Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-11T00:52:51.736207Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgPreVoteResp from b844c110b9783e73 at term 1"} {"level":"info","ts":"2026-05-11T00:52:51.736225Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became candidate at term 2"} {"level":"info","ts":"2026-05-11T00:52:51.736237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgVoteResp from b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-05-11T00:52:51.736252Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became leader at term 2"} {"level":"info","ts":"2026-05-11T00:52:51.73628Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b844c110b9783e73 elected leader b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-05-11T00:52:51.737144Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-11T00:52:51.73714Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b844c110b9783e73","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.242:2379]}","request-path":"/0/members/b844c110b9783e73/attributes","cluster-id":"49dc9693ccd466a9","publish-timeout":"7s"} {"level":"info","ts":"2026-05-11T00:52:51.737141Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T00:52:51.737211Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-11T00:52:51.737558Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-11T00:52:51.7376Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-11T00:52:51.738263Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T00:52:51.738473Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T00:52:51.738527Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T00:52:51.740509Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-11T00:52:51.742183Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.242:2379"} {"level":"info","ts":"2026-05-11T00:52:56.735296Z","caller":"traceutil/trace.go:171","msg":"trace[484596804] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"133.842725ms","start":"2026-05-11T00:52:56.601427Z","end":"2026-05-11T00:52:56.735269Z","steps":["trace[484596804] 'process raft request' (duration: 133.685403ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T00:52:57.146745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.078408ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T00:52:57.147057Z","caller":"traceutil/trace.go:171","msg":"trace[1152077170] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"507.2096ms","start":"2026-05-11T00:52:56.639818Z","end":"2026-05-11T00:52:57.147028Z","steps":["trace[1152077170] 'process raft request' (duration: 243.374243ms)","trace[1152077170] 'compare' (duration: 262.956027ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T00:52:57.147091Z","caller":"traceutil/trace.go:171","msg":"trace[869354181] linearizableReadLoop","detail":"{readStateIndex:306; appliedIndex:304; }","duration":"181.86283ms","start":"2026-05-11T00:52:56.96518Z","end":"2026-05-11T00:52:57.147043Z","steps":["trace[869354181] 'read index received' (duration: 28.696265ms)","trace[869354181] 'applied index is now lower than readState.Index' (duration: 153.161555ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T00:52:57.147175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T00:52:56.639788Z","time spent":"507.330402ms","remote":"127.0.0.1:44502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":203,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T00:52:57.147375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.128463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T00:52:57.147434Z","caller":"traceutil/trace.go:171","msg":"trace[1910309615] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:298; }","duration":"182.291024ms","start":"2026-05-11T00:52:56.965127Z","end":"2026-05-11T00:52:57.147418Z","steps":["trace[1910309615] 'agreement among raft nodes before linearized reading' (duration: 182.076452ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T00:52:57.147282Z","caller":"traceutil/trace.go:171","msg":"trace[1454750682] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"406.446323ms","start":"2026-05-11T00:52:56.740815Z","end":"2026-05-11T00:52:57.147261Z","steps":["trace[1454750682] 'process raft request' (duration: 406.049999ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T00:52:57.147603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T00:52:56.740795Z","time spent":"406.716146ms","remote":"127.0.0.1:44734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2651,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T00:53:00.328055Z","caller":"traceutil/trace.go:171","msg":"trace[1922790812] transaction","detail":"{read_only:false; response_revision:338; number_of_response:1; }","duration":"137.826876ms","start":"2026-05-11T00:53:00.190195Z","end":"2026-05-11T00:53:00.328022Z","steps":["trace[1922790812] 'process raft request' (duration: 137.644164ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T00:53:28.670684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.716741ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T00:53:28.670849Z","caller":"traceutil/trace.go:171","msg":"trace[1543513908] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:618; }","duration":"542.894032ms","start":"2026-05-11T00:53:28.12793Z","end":"2026-05-11T00:53:28.670824Z","steps":["trace[1543513908] 'range keys from in-memory index tree' (duration: 542.68796ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T00:53:28.671102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"842.752019ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T00:53:28.671942Z","caller":"traceutil/trace.go:171","msg":"trace[1269429857] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"1.041061199s","start":"2026-05-11T00:53:27.630803Z","end":"2026-05-11T00:53:28.671865Z","steps":["trace[1269429857] 'process raft request' (duration: 197.313901ms)","trace[1269429857] 'compare' (duration: 842.616737ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T00:53:28.672087Z","caller":"traceutil/trace.go:171","msg":"trace[525976669] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"608.734645ms","start":"2026-05-11T00:53:28.063333Z","end":"2026-05-11T00:53:28.672067Z","steps":["trace[525976669] 'process raft request' (duration: 608.161089ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T00:53:28.671981Z","caller":"traceutil/trace.go:171","msg":"trace[1009194975] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:638; }","duration":"1.010774468s","start":"2026-05-11T00:53:27.661167Z","end":"2026-05-11T00:53:28.671942Z","steps":["trace[1009194975] 'read index received' (duration: 28.071431ms)","trace[1009194975] 'applied index is now lower than readState.Index' (duration: 982.698916ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T00:53:28.672157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T00:53:28.063311Z","time spent":"608.817195ms","remote":"127.0.0.1:44368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036277,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T00:53:28.672245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.011055521s","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-05-11T00:53:28.672303Z","caller":"traceutil/trace.go:171","msg":"trace[692246089] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:620; }","duration":"1.011172012s","start":"2026-05-11T00:53:27.661119Z","end":"2026-05-11T00:53:28.672291Z","steps":["trace[692246089] 'agreement among raft nodes before linearized reading' (duration: 1.010917808s)"],"step_count":1} {"level":"warn","ts":"2026-05-11T00:53:28.672265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T00:53:27.630782Z","time spent":"1.041280662s","remote":"127.0.0.1:44552","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-05-11T00:53:28.672343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T00:53:27.661099Z","time spent":"1.011235912s","remote":"127.0.0.1:44552","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":"warn","ts":"2026-05-11T00:53:28.672351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.196069ms","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-05-11T00:53:28.672405Z","caller":"traceutil/trace.go:171","msg":"trace[523280023] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:620; }","duration":"134.28839ms","start":"2026-05-11T00:53:28.5381Z","end":"2026-05-11T00:53:28.672388Z","steps":["trace[523280023] 'agreement among raft nodes before linearized reading' (duration: 134.119508ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T00:53:29.129067Z","caller":"traceutil/trace.go:171","msg":"trace[1951815308] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:643; }","duration":"162.132453ms","start":"2026-05-11T00:53:28.966909Z","end":"2026-05-11T00:53:29.129041Z","steps":["trace[1951815308] 'read index received' (duration: 161.971641ms)","trace[1951815308] 'applied index is now lower than readState.Index' (duration: 159.952µs)"],"step_count":2} {"level":"info","ts":"2026-05-11T00:53:29.129113Z","caller":"traceutil/trace.go:171","msg":"trace[1045445544] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"392.221851ms","start":"2026-05-11T00:53:28.736867Z","end":"2026-05-11T00:53:29.129089Z","steps":["trace[1045445544] 'process raft request' (duration: 392.036519ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T00:53:29.129219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.302874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T00:53:29.129232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T00:53:28.736838Z","time spent":"392.327973ms","remote":"127.0.0.1:44780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T00:53:29.129252Z","caller":"traceutil/trace.go:171","msg":"trace[1737589641] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"162.415664ms","start":"2026-05-11T00:53:28.966826Z","end":"2026-05-11T00:53:29.129241Z","steps":["trace[1737589641] 'agreement among raft nodes before linearized reading' (duration: 162.313134ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T00:54:17.166826Z","caller":"traceutil/trace.go:171","msg":"trace[960527167] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"229.299153ms","start":"2026-05-11T00:54:16.937495Z","end":"2026-05-11T00:54:17.166794Z","steps":["trace[960527167] 'process raft request' (duration: 229.17631ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T00:54:17.167819Z","caller":"traceutil/trace.go:171","msg":"trace[135453411] linearizableReadLoop","detail":"{readStateIndex:1232; appliedIndex:1229; }","duration":"200.061639ms","start":"2026-05-11T00:54:16.96774Z","end":"2026-05-11T00:54:17.167801Z","steps":["trace[135453411] 'read index received' (duration: 198.881012ms)","trace[135453411] 'applied index is now lower than readState.Index' (duration: 1.179977ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T00:54:17.167915Z","caller":"traceutil/trace.go:171","msg":"trace[981694145] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"229.090887ms","start":"2026-05-11T00:54:16.938795Z","end":"2026-05-11T00:54:17.167886Z","steps":["trace[981694145] 'process raft request' (duration: 228.88111ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T00:54:17.168051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.303456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T00:54:17.1681Z","caller":"traceutil/trace.go:171","msg":"trace[570006017] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1198; }","duration":"200.440251ms","start":"2026-05-11T00:54:16.967653Z","end":"2026-05-11T00:54:17.168093Z","steps":["trace[570006017] 'agreement among raft nodes before linearized reading' (duration: 200.355338ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T00:54:17.167954Z","caller":"traceutil/trace.go:171","msg":"trace[1164874393] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"228.860559ms","start":"2026-05-11T00:54:16.939081Z","end":"2026-05-11T00:54:17.167942Z","steps":["trace[1164874393] 'process raft request' (duration: 228.695304ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T00:54:17.16832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.458588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" ","response":"range_response_count:1 size:224"} {"level":"info","ts":"2026-05-11T00:54:17.168352Z","caller":"traceutil/trace.go:171","msg":"trace[2146384808] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-after-finished-controller; range_end:; response_count:1; response_revision:1198; }","duration":"166.531201ms","start":"2026-05-11T00:54:17.001814Z","end":"2026-05-11T00:54:17.168345Z","steps":["trace[2146384808] 'agreement among raft nodes before linearized reading' (duration: 166.139449ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T00:55:03.720642Z","caller":"traceutil/trace.go:171","msg":"trace[1779597187] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"331.314012ms","start":"2026-05-11T00:55:03.389287Z","end":"2026-05-11T00:55:03.720602Z","steps":["trace[1779597187] 'process raft request' (duration: 268.355202ms)","trace[1779597187] 'compare' (duration: 62.628453ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T00:55:03.720973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T00:55:03.389267Z","time spent":"331.475636ms","remote":"127.0.0.1:44552","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-05-11T00:55:03.721041Z","caller":"traceutil/trace.go:171","msg":"trace[471827227] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"329.77859ms","start":"2026-05-11T00:55:03.391239Z","end":"2026-05-11T00:55:03.721017Z","steps":["trace[471827227] 'process raft request' (duration: 329.627276ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T00:55:03.721201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T00:55:03.391228Z","time spent":"329.892962ms","remote":"127.0.0.1:44552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T00:55:03.7213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.73148ms","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-05-11T00:55:03.721359Z","caller":"traceutil/trace.go:171","msg":"trace[252737665] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1874; }","duration":"330.829682ms","start":"2026-05-11T00:55:03.390515Z","end":"2026-05-11T00:55:03.721344Z","steps":["trace[252737665] 'agreement among raft nodes before linearized reading' (duration: 330.663548ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T00:55:03.721426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T00:55:03.390494Z","time spent":"330.923843ms","remote":"127.0.0.1:44552","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":"info","ts":"2026-05-11T00:55:03.721696Z","caller":"traceutil/trace.go:171","msg":"trace[249833735] linearizableReadLoop","detail":"{readStateIndex:1945; appliedIndex:1944; }","duration":"330.438053ms","start":"2026-05-11T00:55:03.390566Z","end":"2026-05-11T00:55:03.721004Z","steps":["trace[249833735] 'read index received' (duration: 267.094294ms)","trace[249833735] 'applied index is now lower than readState.Index' (duration: 63.341429ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T00:55:03.72187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.376564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-11T00:55:03.721907Z","caller":"traceutil/trace.go:171","msg":"trace[1961869328] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1874; }","duration":"127.462896ms","start":"2026-05-11T00:55:03.594434Z","end":"2026-05-11T00:55:03.721897Z","steps":["trace[1961869328] 'agreement among raft nodes before linearized reading' (duration: 127.364864ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T00:55:04.036996Z","caller":"traceutil/trace.go:171","msg":"trace[1769635070] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"100.538484ms","start":"2026-05-11T00:55:03.936423Z","end":"2026-05-11T00:55:04.036961Z","steps":["trace[1769635070] 'process raft request' (duration: 100.322139ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T00:55:15.900501Z","caller":"traceutil/trace.go:171","msg":"trace[359177576] linearizableReadLoop","detail":"{readStateIndex:2051; appliedIndex:2049; }","duration":"124.639926ms","start":"2026-05-11T00:55:15.775837Z","end":"2026-05-11T00:55:15.900477Z","steps":["trace[359177576] 'read index received' (duration: 92.273011ms)","trace[359177576] 'applied index is now lower than readState.Index' (duration: 32.365845ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T00:55:15.900932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.063365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-11T00:55:15.901036Z","caller":"traceutil/trace.go:171","msg":"trace[1149278053] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1975; }","duration":"125.189378ms","start":"2026-05-11T00:55:15.775823Z","end":"2026-05-11T00:55:15.901013Z","steps":["trace[1149278053] 'agreement among raft nodes before linearized reading' (duration: 124.80428ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T00:55:15.901082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.925079ms","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-05-11T00:55:15.901145Z","caller":"traceutil/trace.go:171","msg":"trace[1748681006] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1975; }","duration":"111.017941ms","start":"2026-05-11T00:55:15.790112Z","end":"2026-05-11T00:55:15.90113Z","steps":["trace[1748681006] 'agreement among raft nodes before linearized reading' (duration: 110.783666ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T00:55:15.90106Z","caller":"traceutil/trace.go:171","msg":"trace[1098007576] transaction","detail":"{read_only:false; response_revision:1975; number_of_response:1; }","duration":"126.664189ms","start":"2026-05-11T00:55:15.774317Z","end":"2026-05-11T00:55:15.900981Z","steps":["trace[1098007576] 'process raft request' (duration: 123.106276ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T00:55:32.444974Z","caller":"traceutil/trace.go:171","msg":"trace[1611747235] transaction","detail":"{read_only:false; response_revision:2086; number_of_response:1; }","duration":"141.821467ms","start":"2026-05-11T00:55:32.303125Z","end":"2026-05-11T00:55:32.444947Z","steps":["trace[1611747235] 'process raft request' (duration: 133.537033ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T00:55:38.569288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.531857ms","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-05-11T00:55:38.569509Z","caller":"traceutil/trace.go:171","msg":"trace[817183074] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2118; }","duration":"101.792921ms","start":"2026-05-11T00:55:38.467694Z","end":"2026-05-11T00:55:38.569487Z","steps":["trace[817183074] 'range keys from in-memory index tree' (duration: 101.293783ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T00:55:39.19742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.834666ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T00:55:39.197516Z","caller":"traceutil/trace.go:171","msg":"trace[624068034] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"188.897904ms","start":"2026-05-11T00:55:39.008603Z","end":"2026-05-11T00:55:39.197501Z","steps":["trace[624068034] 'process raft request' (duration: 77.864263ms)","trace[624068034] 'compare' (duration: 110.546481ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T00:56:49.322474Z","caller":"traceutil/trace.go:171","msg":"trace[1180421081] transaction","detail":"{read_only:false; response_revision:2598; number_of_response:1; }","duration":"177.76876ms","start":"2026-05-11T00:56:49.144673Z","end":"2026-05-11T00:56:49.322442Z","steps":["trace[1180421081] 'process raft request' (duration: 177.07745ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T00:57:09.780796Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500114263653886325,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-11T00:57:10.282173Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500114263653886325,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-11T00:57:10.369138Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.365890548s","expected-duration":"1s"} {"level":"info","ts":"2026-05-11T00:57:10.369905Z","caller":"traceutil/trace.go:171","msg":"trace[539181208] transaction","detail":"{read_only:false; response_revision:2713; number_of_response:1; }","duration":"1.366735112s","start":"2026-05-11T00:57:09.003138Z","end":"2026-05-11T00:57:10.369873Z","steps":["trace[539181208] 'process raft request' (duration: 1.366545089s)"],"step_count":1} {"level":"warn","ts":"2026-05-11T00:57:10.370155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T00:57:09.003115Z","time spent":"1.366951914s","remote":"127.0.0.1:44552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T00:57:10.379899Z","caller":"traceutil/trace.go:171","msg":"trace[1128183464] transaction","detail":"{read_only:false; response_revision:2714; number_of_response:1; }","duration":"989.188214ms","start":"2026-05-11T00:57:09.390683Z","end":"2026-05-11T00:57:10.379871Z","steps":["trace[1128183464] 'process raft request' (duration: 987.001752ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T00:57:10.379983Z","caller":"traceutil/trace.go:171","msg":"trace[1912933076] transaction","detail":"{read_only:false; response_revision:2715; number_of_response:1; }","duration":"881.074889ms","start":"2026-05-11T00:57:09.498891Z","end":"2026-05-11T00:57:10.379966Z","steps":["trace[1912933076] 'process raft request' (duration: 880.909297ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T00:57:10.380067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T00:57:09.390655Z","time spent":"989.331036ms","remote":"127.0.0.1:44552","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-05-11T00:57:10.380114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T00:57:09.498867Z","time spent":"881.168231ms","remote":"127.0.0.1:44552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T00:57:10.384176Z","caller":"traceutil/trace.go:171","msg":"trace[1404685014] linearizableReadLoop","detail":"{readStateIndex:2817; appliedIndex:2813; }","duration":"1.104164778s","start":"2026-05-11T00:57:09.279997Z","end":"2026-05-11T00:57:10.384162Z","steps":["trace[1404685014] 'read index received' (duration: 1.089685121s)","trace[1404685014] 'applied index is now lower than readState.Index' (duration: 14.478517ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T00:57:10.384336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.104339361s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-05-11T00:57:10.384394Z","caller":"traceutil/trace.go:171","msg":"trace[780194027] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2715; }","duration":"1.104435273s","start":"2026-05-11T00:57:09.27995Z","end":"2026-05-11T00:57:10.384385Z","steps":["trace[780194027] 'agreement among raft nodes before linearized reading' (duration: 1.104293911s)"],"step_count":1} {"level":"warn","ts":"2026-05-11T00:57:10.384422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T00:57:09.279934Z","time spent":"1.104481793s","remote":"127.0.0.1:44490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1392,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"warn","ts":"2026-05-11T00:57:10.384397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.04521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T00:57:10.384467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.531941ms","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-05-11T00:57:10.384492Z","caller":"traceutil/trace.go:171","msg":"trace[152619271] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2715; }","duration":"418.197392ms","start":"2026-05-11T00:57:09.966273Z","end":"2026-05-11T00:57:10.38447Z","steps":["trace[152619271] 'agreement among raft nodes before linearized reading' (duration: 418.02923ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T00:57:10.384555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T00:57:09.966254Z","time spent":"418.291684ms","remote":"127.0.0.1:44230","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-05-11T00:57:10.384551Z","caller":"traceutil/trace.go:171","msg":"trace[1427640541] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:2715; }","duration":"293.673783ms","start":"2026-05-11T00:57:10.090858Z","end":"2026-05-11T00:57:10.384532Z","steps":["trace[1427640541] 'agreement among raft nodes before linearized reading' (duration: 293.50446ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T00:57:22.739439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.809779ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T00:57:22.739784Z","caller":"traceutil/trace.go:171","msg":"trace[1972762270] transaction","detail":"{read_only:false; response_revision:2778; number_of_response:1; }","duration":"312.958805ms","start":"2026-05-11T00:57:22.426801Z","end":"2026-05-11T00:57:22.73976Z","steps":["trace[1972762270] 'process raft request' (duration: 162.74926ms)","trace[1972762270] 'compare' (duration: 149.368183ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T00:57:22.73994Z","caller":"traceutil/trace.go:171","msg":"trace[1891002812] linearizableReadLoop","detail":"{readStateIndex:2882; appliedIndex:2880; }","duration":"312.935325ms","start":"2026-05-11T00:57:22.426971Z","end":"2026-05-11T00:57:22.739906Z","steps":["trace[1891002812] 'read index received' (duration: 37.082383ms)","trace[1891002812] 'applied index is now lower than readState.Index' (duration: 275.846342ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T00:57:22.739956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T00:57:22.426787Z","time spent":"313.050736ms","remote":"127.0.0.1:44552","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-05-11T00:57:22.740164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.158818ms","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-05-11T00:57:22.740269Z","caller":"traceutil/trace.go:171","msg":"trace[2055449049] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2778; }","duration":"313.31008ms","start":"2026-05-11T00:57:22.42694Z","end":"2026-05-11T00:57:22.74025Z","steps":["trace[2055449049] 'agreement among raft nodes before linearized reading' (duration: 313.068856ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T00:57:22.740252Z","caller":"traceutil/trace.go:171","msg":"trace[428784389] transaction","detail":"{read_only:false; response_revision:2779; number_of_response:1; }","duration":"222.370079ms","start":"2026-05-11T00:57:22.517867Z","end":"2026-05-11T00:57:22.740237Z","steps":["trace[428784389] 'process raft request' (duration: 221.67409ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T00:57:22.740323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T00:57:22.426931Z","time spent":"313.381621ms","remote":"127.0.0.1:44552","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-05-11T00:57:22.745835Z","caller":"traceutil/trace.go:171","msg":"trace[1518331906] transaction","detail":"{read_only:false; response_revision:2780; number_of_response:1; }","duration":"100.851149ms","start":"2026-05-11T00:57:22.644969Z","end":"2026-05-11T00:57:22.74582Z","steps":["trace[1518331906] 'process raft request' (duration: 100.742048ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T00:57:22.746175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.84118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18ae5ce09a06c026\" ","response":"range_response_count:1 size:779"} {"level":"info","ts":"2026-05-11T00:57:22.746239Z","caller":"traceutil/trace.go:171","msg":"trace[1163490035] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18ae5ce09a06c026; range_end:; response_count:1; response_revision:2780; }","duration":"159.933871ms","start":"2026-05-11T00:57:22.58629Z","end":"2026-05-11T00:57:22.746224Z","steps":["trace[1163490035] 'agreement among raft nodes before linearized reading' (duration: 159.683417ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T00:57:22.746316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.717166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T00:57:22.746686Z","caller":"traceutil/trace.go:171","msg":"trace[89703185] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2780; }","duration":"233.106991ms","start":"2026-05-11T00:57:22.513541Z","end":"2026-05-11T00:57:22.746648Z","steps":["trace[89703185] 'agreement among raft nodes before linearized reading' (duration: 232.724905ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T00:57:22.746507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.176875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-11T00:57:22.746755Z","caller":"traceutil/trace.go:171","msg":"trace[1428555086] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2780; }","duration":"175.4603ms","start":"2026-05-11T00:57:22.571284Z","end":"2026-05-11T00:57:22.746745Z","steps":["trace[1428555086] 'agreement among raft nodes before linearized reading' (duration: 175.118304ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T00:57:22.746514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.014808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-11T00:57:22.746861Z","caller":"traceutil/trace.go:171","msg":"trace[1968923904] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2780; }","duration":"228.368865ms","start":"2026-05-11T00:57:22.518469Z","end":"2026-05-11T00:57:22.746838Z","steps":["trace[1968923904] 'agreement among raft nodes before linearized reading' (duration: 227.979999ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T00:57:22.746706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.001197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-05-11T00:57:22.746492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.470705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-11T00:57:22.746997Z","caller":"traceutil/trace.go:171","msg":"trace[2062921538] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2780; }","duration":"175.022954ms","start":"2026-05-11T00:57:22.571967Z","end":"2026-05-11T00:57:22.74699Z","steps":["trace[2062921538] 'agreement among raft nodes before linearized reading' (duration: 174.381414ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T00:57:22.747253Z","caller":"traceutil/trace.go:171","msg":"trace[922064119] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2780; }","duration":"171.256611ms","start":"2026-05-11T00:57:22.575695Z","end":"2026-05-11T00:57:22.746952Z","steps":["trace[922064119] 'agreement among raft nodes before linearized reading' (duration: 170.739622ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T01:01:13.267964Z","caller":"traceutil/trace.go:171","msg":"trace[1956115637] transaction","detail":"{read_only:false; response_revision:4681; number_of_response:1; }","duration":"124.733211ms","start":"2026-05-11T01:01:13.1432Z","end":"2026-05-11T01:01:13.267934Z","steps":["trace[1956115637] 'process raft request' (duration: 124.517517ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T01:01:20.194994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.589069ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T01:01:20.195175Z","caller":"traceutil/trace.go:171","msg":"trace[59482077] transaction","detail":"{read_only:false; response_revision:4790; number_of_response:1; }","duration":"220.296266ms","start":"2026-05-11T01:01:19.974855Z","end":"2026-05-11T01:01:20.195151Z","steps":["trace[59482077] 'process raft request' (duration: 85.405679ms)","trace[59482077] 'compare' (duration: 134.294173ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T01:01:20.211858Z","caller":"traceutil/trace.go:171","msg":"trace[90134934] transaction","detail":"{read_only:false; response_revision:4791; number_of_response:1; }","duration":"236.975258ms","start":"2026-05-11T01:01:19.974861Z","end":"2026-05-11T01:01:20.211837Z","steps":["trace[90134934] 'process raft request' (duration: 236.740113ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T01:01:20.21195Z","caller":"traceutil/trace.go:171","msg":"trace[1674183757] transaction","detail":"{read_only:false; response_revision:4793; number_of_response:1; }","duration":"236.807955ms","start":"2026-05-11T01:01:19.975116Z","end":"2026-05-11T01:01:20.211924Z","steps":["trace[1674183757] 'process raft request' (duration: 236.709101ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T01:01:20.212177Z","caller":"traceutil/trace.go:171","msg":"trace[1691747724] transaction","detail":"{read_only:false; response_revision:4794; number_of_response:1; }","duration":"234.809681ms","start":"2026-05-11T01:01:19.977348Z","end":"2026-05-11T01:01:20.212158Z","steps":["trace[1691747724] 'process raft request' (duration: 234.529724ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T01:01:20.211963Z","caller":"traceutil/trace.go:171","msg":"trace[586822988] transaction","detail":"{read_only:false; response_revision:4792; number_of_response:1; }","duration":"236.902017ms","start":"2026-05-11T01:01:19.975021Z","end":"2026-05-11T01:01:20.211923Z","steps":["trace[586822988] 'process raft request' (duration: 236.755552ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T01:01:20.234978Z","caller":"traceutil/trace.go:171","msg":"trace[107796796] linearizableReadLoop","detail":"{readStateIndex:4973; appliedIndex:4969; }","duration":"258.755772ms","start":"2026-05-11T01:01:19.976181Z","end":"2026-05-11T01:01:20.234937Z","steps":["trace[107796796] 'read index received' (duration: 84.193993ms)","trace[107796796] 'applied index is now lower than readState.Index' (duration: 174.559239ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T01:01:20.235395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.176322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"info","ts":"2026-05-11T01:01:20.23551Z","caller":"traceutil/trace.go:171","msg":"trace[335314283] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4795; }","duration":"259.338815ms","start":"2026-05-11T01:01:19.976147Z","end":"2026-05-11T01:01:20.235486Z","steps":["trace[335314283] 'agreement among raft nodes before linearized reading' (duration: 258.940296ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T01:01:20.235717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.993786ms","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-05-11T01:01:20.235809Z","caller":"traceutil/trace.go:171","msg":"trace[1794461965] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4795; }","duration":"202.302592ms","start":"2026-05-11T01:01:20.033482Z","end":"2026-05-11T01:01:20.235784Z","steps":["trace[1794461965] 'agreement among raft nodes before linearized reading' (duration: 201.921644ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T01:01:20.236423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.482277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-05-11T01:01:20.236696Z","caller":"traceutil/trace.go:171","msg":"trace[998514131] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4795; }","duration":"259.673641ms","start":"2026-05-11T01:01:19.97685Z","end":"2026-05-11T01:01:20.236524Z","steps":["trace[998514131] 'agreement among raft nodes before linearized reading' (duration: 258.276311ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T01:01:36.477751Z","caller":"traceutil/trace.go:171","msg":"trace[1112144674] linearizableReadLoop","detail":"{readStateIndex:5181; appliedIndex:5180; }","duration":"148.441409ms","start":"2026-05-11T01:01:36.329277Z","end":"2026-05-11T01:01:36.477718Z","steps":["trace[1112144674] 'read index received' (duration: 148.189234ms)","trace[1112144674] 'applied index is now lower than readState.Index' (duration: 245.845µs)"],"step_count":2} {"level":"warn","ts":"2026-05-11T01:01:36.478099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.796916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-05-11T01:01:36.478095Z","caller":"traceutil/trace.go:171","msg":"trace[150910580] transaction","detail":"{read_only:false; response_revision:4994; number_of_response:1; }","duration":"250.439346ms","start":"2026-05-11T01:01:36.227462Z","end":"2026-05-11T01:01:36.477902Z","steps":["trace[150910580] 'process raft request' (duration: 250.028087ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T01:01:36.478196Z","caller":"traceutil/trace.go:171","msg":"trace[972060611] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4994; }","duration":"148.95496ms","start":"2026-05-11T01:01:36.329218Z","end":"2026-05-11T01:01:36.478173Z","steps":["trace[972060611] 'agreement among raft nodes before linearized reading' (duration: 148.634433ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T01:01:36.478348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.181434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-11T01:01:36.478451Z","caller":"traceutil/trace.go:171","msg":"trace[1576441596] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4994; }","duration":"140.369728ms","start":"2026-05-11T01:01:36.338067Z","end":"2026-05-11T01:01:36.478437Z","steps":["trace[1576441596] 'agreement among raft nodes before linearized reading' (duration: 139.97143ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T01:01:36.478632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.730169ms","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-05-11T01:01:36.478658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.879219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-11T01:01:36.478701Z","caller":"traceutil/trace.go:171","msg":"trace[2115449989] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4994; }","duration":"131.94601ms","start":"2026-05-11T01:01:36.346743Z","end":"2026-05-11T01:01:36.478689Z","steps":["trace[2115449989] 'agreement among raft nodes before linearized reading' (duration: 131.819888ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T01:01:36.478813Z","caller":"traceutil/trace.go:171","msg":"trace[550834803] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4994; }","duration":"134.861411ms","start":"2026-05-11T01:01:36.343827Z","end":"2026-05-11T01:01:36.478688Z","steps":["trace[550834803] 'agreement among raft nodes before linearized reading' (duration: 134.360021ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T01:01:36.478871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.202929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-11T01:01:36.478914Z","caller":"traceutil/trace.go:171","msg":"trace[145206628] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4994; }","duration":"135.289121ms","start":"2026-05-11T01:01:36.343616Z","end":"2026-05-11T01:01:36.478905Z","steps":["trace[145206628] 'agreement among raft nodes before linearized reading' (duration: 135.157458ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T01:01:36.478982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.815586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-11T01:01:36.479061Z","caller":"traceutil/trace.go:171","msg":"trace[1550128096] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4994; }","duration":"139.94844ms","start":"2026-05-11T01:01:36.3391Z","end":"2026-05-11T01:01:36.479049Z","steps":["trace[1550128096] 'agreement among raft nodes before linearized reading' (duration: 139.700255ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T01:02:15.620074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.232354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T01:02:15.620193Z","caller":"traceutil/trace.go:171","msg":"trace[2113964420] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5328; }","duration":"168.419679ms","start":"2026-05-11T01:02:15.45175Z","end":"2026-05-11T01:02:15.62017Z","steps":["trace[2113964420] 'range keys from in-memory index tree' (duration: 168.074581ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T01:02:15.6202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.447199ms","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-05-11T01:02:15.620277Z","caller":"traceutil/trace.go:171","msg":"trace[1547391623] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5328; }","duration":"168.562982ms","start":"2026-05-11T01:02:15.451694Z","end":"2026-05-11T01:02:15.620257Z","steps":["trace[1547391623] 'range keys from in-memory index tree' (duration: 168.266705ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T01:02:15.620281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.360707ms","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-05-11T01:02:15.620345Z","caller":"traceutil/trace.go:171","msg":"trace[531694810] range","detail":"{range_begin:/registry/jobs/openstack/keystone-credential-setup; range_end:; response_count:1; response_revision:5328; }","duration":"165.447048ms","start":"2026-05-11T01:02:15.454885Z","end":"2026-05-11T01:02:15.620332Z","steps":["trace[531694810] 'range keys from in-memory index tree' (duration: 165.155742ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T01:02:15.619946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.614042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T01:02:15.620477Z","caller":"traceutil/trace.go:171","msg":"trace[157352686] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:5328; }","duration":"311.245146ms","start":"2026-05-11T01:02:15.309217Z","end":"2026-05-11T01:02:15.620462Z","steps":["trace[157352686] 'count revisions from in-memory index tree' (duration: 310.394108ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T01:02:15.620512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T01:02:15.309201Z","time spent":"311.297597ms","remote":"127.0.0.1:45558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true "} {"level":"info","ts":"2026-05-11T01:02:18.348017Z","caller":"traceutil/trace.go:171","msg":"trace[1884713054] transaction","detail":"{read_only:false; response_revision:5345; number_of_response:1; }","duration":"150.06631ms","start":"2026-05-11T01:02:18.197933Z","end":"2026-05-11T01:02:18.347999Z","steps":["trace[1884713054] 'process raft request' (duration: 149.937877ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T01:02:18.350765Z","caller":"traceutil/trace.go:171","msg":"trace[2067156595] linearizableReadLoop","detail":"{readStateIndex:5543; appliedIndex:5541; }","duration":"148.484189ms","start":"2026-05-11T01:02:18.202272Z","end":"2026-05-11T01:02:18.350756Z","steps":["trace[2067156595] 'read index received' (duration: 145.707684ms)","trace[2067156595] 'applied index is now lower than readState.Index' (duration: 2.776125ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T01:02:18.35088Z","caller":"traceutil/trace.go:171","msg":"trace[1681286438] transaction","detail":"{read_only:false; response_revision:5346; number_of_response:1; }","duration":"152.679822ms","start":"2026-05-11T01:02:18.198193Z","end":"2026-05-11T01:02:18.350873Z","steps":["trace[1681286438] 'process raft request' (duration: 152.515228ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T01:02:18.350998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.702824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-11T01:02:18.351023Z","caller":"traceutil/trace.go:171","msg":"trace[1626036598] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:5346; }","duration":"148.775715ms","start":"2026-05-11T01:02:18.202241Z","end":"2026-05-11T01:02:18.351017Z","steps":["trace[1626036598] 'agreement among raft nodes before linearized reading' (duration: 148.714844ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T01:02:18.351147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.719104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T01:02:18.351164Z","caller":"traceutil/trace.go:171","msg":"trace[1033699300] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:5346; }","duration":"148.745474ms","start":"2026-05-11T01:02:18.202413Z","end":"2026-05-11T01:02:18.351159Z","steps":["trace[1033699300] 'agreement among raft nodes before linearized reading' (duration: 148.712884ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T01:02:51.76576Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2934} {"level":"info","ts":"2026-05-11T01:02:51.871209Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2934,"took":"104.15407ms","hash":1502295291,"current-db-size-bytes":52944896,"current-db-size":"53 MB","current-db-size-in-use-bytes":29155328,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-11T01:02:51.871271Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1502295291,"revision":2934,"compact-revision":-1} {"level":"info","ts":"2026-05-11T01:07:51.77099Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5605} {"level":"info","ts":"2026-05-11T01:07:51.846052Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5605,"took":"73.110971ms","hash":1453443139,"current-db-size-bytes":52944896,"current-db-size":"53 MB","current-db-size-in-use-bytes":18440192,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-11T01:07:51.846119Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1453443139,"revision":5605,"compact-revision":2934}