{"level":"warn","ts":"2026-04-15T07:25:54.301265Z","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-15T07:25:54.301374Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.25: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.19.213.25:2380","--initial-cluster=instance=https://199.19.213.25:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.25:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.25: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-15T07:25:54.301476Z","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-15T07:25:54.3015Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.25:2380"]} {"level":"info","ts":"2026-04-15T07:25:54.301535Z","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-15T07:25:54.302448Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.25:2379"]} {"level":"info","ts":"2026-04-15T07:25:54.302652Z","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.19.213.25:2380"],"listen-peer-urls":["https://199.19.213.25:2380"],"advertise-client-urls":["https://199.19.213.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.25: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-15T07:25:54.306892Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.866672ms"} {"level":"info","ts":"2026-04-15T07:25:54.31354Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9bd4db28c48efaf1","cluster-id":"b621f59192c78404"} {"level":"info","ts":"2026-04-15T07:25:54.313613Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 switched to configuration voters=()"} {"level":"info","ts":"2026-04-15T07:25:54.313636Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became follower at term 0"} {"level":"info","ts":"2026-04-15T07:25:54.313651Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9bd4db28c48efaf1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-15T07:25:54.313659Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became follower at term 1"} {"level":"info","ts":"2026-04-15T07:25:54.313693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 switched to configuration voters=(11228840739084368625)"} {"level":"warn","ts":"2026-04-15T07:25:54.320594Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-15T07:25:54.322152Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-15T07:25:54.323534Z","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-15T07:25:54.325759Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9bd4db28c48efaf1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-15T07:25:54.32623Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9bd4db28c48efaf1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-15T07:25:54.326639Z","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-15T07:25:54.326758Z","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-15T07:25:54.326774Z","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-15T07:25:54.32711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 switched to configuration voters=(11228840739084368625)"} {"level":"info","ts":"2026-04-15T07:25:54.331414Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b621f59192c78404","local-member-id":"9bd4db28c48efaf1","added-peer-id":"9bd4db28c48efaf1","added-peer-peer-urls":["https://199.19.213.25:2380"]} {"level":"info","ts":"2026-04-15T07:25:54.337093Z","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-15T07:25:54.337215Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.25:2380"} {"level":"info","ts":"2026-04-15T07:25:54.337243Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.25:2380"} {"level":"info","ts":"2026-04-15T07:25:54.337391Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9bd4db28c48efaf1","initial-advertise-peer-urls":["https://199.19.213.25:2380"],"listen-peer-urls":["https://199.19.213.25:2380"],"advertise-client-urls":["https://199.19.213.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-15T07:25:54.33745Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-15T07:25:54.513906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 is starting a new election at term 1"} {"level":"info","ts":"2026-04-15T07:25:54.513972Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-15T07:25:54.513998Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 received MsgPreVoteResp from 9bd4db28c48efaf1 at term 1"} {"level":"info","ts":"2026-04-15T07:25:54.514125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became candidate at term 2"} {"level":"info","ts":"2026-04-15T07:25:54.514149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 received MsgVoteResp from 9bd4db28c48efaf1 at term 2"} {"level":"info","ts":"2026-04-15T07:25:54.514164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became leader at term 2"} {"level":"info","ts":"2026-04-15T07:25:54.51427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9bd4db28c48efaf1 elected leader 9bd4db28c48efaf1 at term 2"} {"level":"info","ts":"2026-04-15T07:25:54.51509Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T07:25:54.515831Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-15T07:25:54.515852Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-15T07:25:54.515827Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9bd4db28c48efaf1","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.25:2379]}","request-path":"/0/members/9bd4db28c48efaf1/attributes","cluster-id":"b621f59192c78404","publish-timeout":"7s"} {"level":"info","ts":"2026-04-15T07:25:54.516266Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-15T07:25:54.516341Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-15T07:25:54.516391Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b621f59192c78404","local-member-id":"9bd4db28c48efaf1","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T07:25:54.51681Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T07:25:54.516843Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T07:25:54.519004Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.25:2379"} {"level":"info","ts":"2026-04-15T07:25:54.519391Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-15T07:26:00.743445Z","caller":"traceutil/trace.go:171","msg":"trace[71577822] transaction","detail":"{read_only:false; response_revision:263; number_of_response:1; }","duration":"157.012103ms","start":"2026-04-15T07:26:00.586394Z","end":"2026-04-15T07:26:00.743406Z","steps":["trace[71577822] 'process raft request' (duration: 156.782059ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:26:01.007183Z","caller":"traceutil/trace.go:171","msg":"trace[840427442] transaction","detail":"{read_only:false; number_of_response:0; response_revision:263; }","duration":"343.685562ms","start":"2026-04-15T07:26:00.662761Z","end":"2026-04-15T07:26:01.006447Z","steps":["trace[840427442] 'process raft request' (duration: 308.677661ms)","trace[840427442] 'compare' (duration: 34.91044ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:26:01.00775Z","caller":"traceutil/trace.go:171","msg":"trace[1996876015] transaction","detail":"{read_only:false; number_of_response:0; response_revision:263; }","duration":"344.834608ms","start":"2026-04-15T07:26:00.662873Z","end":"2026-04-15T07:26:01.007707Z","steps":["trace[1996876015] 'process raft request' (duration: 344.24188ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:26:01.00829Z","caller":"traceutil/trace.go:171","msg":"trace[887366206] linearizableReadLoop","detail":"{readStateIndex:274; appliedIndex:270; }","duration":"260.880699ms","start":"2026-04-15T07:26:00.747334Z","end":"2026-04-15T07:26:01.008215Z","steps":["trace[887366206] 'read index received' (duration: 224.119224ms)","trace[887366206] 'applied index is now lower than readState.Index' (duration: 36.672984ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:26:01.00871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:26:00.662742Z","time spent":"344.764457ms","remote":"127.0.0.1:50220","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T07:26:01.008733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.359695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:26:01.008855Z","caller":"traceutil/trace.go:171","msg":"trace[20215291] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:0; response_revision:263; }","duration":"261.555318ms","start":"2026-04-15T07:26:00.747282Z","end":"2026-04-15T07:26:01.008837Z","steps":["trace[20215291] 'agreement among raft nodes before linearized reading' (duration: 261.125872ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:26:01.009171Z","caller":"traceutil/trace.go:171","msg":"trace[447870755] transaction","detail":"{read_only:false; number_of_response:0; response_revision:263; }","duration":"346.178886ms","start":"2026-04-15T07:26:00.662928Z","end":"2026-04-15T07:26:01.009106Z","steps":["trace[447870755] 'process raft request' (duration: 344.810468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:26:01.009301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:26:00.662865Z","time spent":"344.960539ms","remote":"127.0.0.1:50220","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T07:26:01.009385Z","caller":"traceutil/trace.go:171","msg":"trace[1143195227] transaction","detail":"{read_only:false; number_of_response:0; response_revision:263; }","duration":"346.218586ms","start":"2026-04-15T07:26:00.663147Z","end":"2026-04-15T07:26:01.009366Z","steps":["trace[1143195227] 'process raft request' (duration: 344.894869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:26:01.009389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:26:00.662918Z","time spent":"346.348648ms","remote":"127.0.0.1:50220","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T07:26:01.009535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:26:00.663138Z","time spent":"346.292327ms","remote":"127.0.0.1:50220","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T07:26:01.100159Z","caller":"traceutil/trace.go:171","msg":"trace[73309096] transaction","detail":"{read_only:false; response_revision:264; number_of_response:1; }","duration":"337.989099ms","start":"2026-04-15T07:26:00.762142Z","end":"2026-04-15T07:26:01.100131Z","steps":["trace[73309096] 'process raft request' (duration: 337.578503ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:26:01.100475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:26:00.762108Z","time spent":"338.1103ms","remote":"127.0.0.1:50220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5311,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T07:26:31.960956Z","caller":"traceutil/trace.go:171","msg":"trace[1492806265] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"210.988524ms","start":"2026-04-15T07:26:31.748844Z","end":"2026-04-15T07:26:31.959833Z","steps":["trace[1492806265] 'process raft request' (duration: 210.258084ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:26:32.18358Z","caller":"traceutil/trace.go:171","msg":"trace[476694331] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"431.914357ms","start":"2026-04-15T07:26:31.751649Z","end":"2026-04-15T07:26:32.183564Z","steps":["trace[476694331] 'process raft request' (duration: 427.716308ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:26:32.183683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:26:31.751626Z","time spent":"432.005368ms","remote":"127.0.0.1:50220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T07:26:32.188282Z","caller":"traceutil/trace.go:171","msg":"trace[1429889662] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:593; }","duration":"118.134004ms","start":"2026-04-15T07:26:32.070131Z","end":"2026-04-15T07:26:32.188265Z","steps":["trace[1429889662] 'read index received' (duration: 109.26707ms)","trace[1429889662] 'applied index is now lower than readState.Index' (duration: 8.865854ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:26:32.188357Z","caller":"traceutil/trace.go:171","msg":"trace[553190967] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"165.139818ms","start":"2026-04-15T07:26:32.023208Z","end":"2026-04-15T07:26:32.188348Z","steps":["trace[553190967] 'process raft request' (duration: 164.971445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:26:32.188601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.446239ms","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-15T07:26:32.188648Z","caller":"traceutil/trace.go:171","msg":"trace[312096800] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:574; }","duration":"118.53994ms","start":"2026-04-15T07:26:32.070093Z","end":"2026-04-15T07:26:32.188633Z","steps":["trace[312096800] 'agreement among raft nodes before linearized reading' (duration: 118.387437ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:26:47.046382Z","caller":"traceutil/trace.go:171","msg":"trace[224407430] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"207.16137ms","start":"2026-04-15T07:26:46.839194Z","end":"2026-04-15T07:26:47.046356Z","steps":["trace[224407430] 'process raft request' (duration: 206.958709ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:27:20.210292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.028325ms","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":"warn","ts":"2026-04-15T07:27:20.210358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.688984ms","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-04-15T07:27:20.210434Z","caller":"traceutil/trace.go:171","msg":"trace[895808733] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-after-finished-controller; range_end:; response_count:1; response_revision:1150; }","duration":"207.240634ms","start":"2026-04-15T07:27:20.003155Z","end":"2026-04-15T07:27:20.210395Z","steps":["trace[895808733] 'range keys from in-memory index tree' (duration: 206.783526ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:27:20.210438Z","caller":"traceutil/trace.go:171","msg":"trace[1239327794] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1150; }","duration":"189.788067ms","start":"2026-04-15T07:27:20.020626Z","end":"2026-04-15T07:27:20.210414Z","steps":["trace[1239327794] 'range keys from in-memory index tree' (duration: 189.539438ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:27:20.210046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.781867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-15T07:27:20.211033Z","caller":"traceutil/trace.go:171","msg":"trace[58345632] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1150; }","duration":"175.818838ms","start":"2026-04-15T07:27:20.035201Z","end":"2026-04-15T07:27:20.21102Z","steps":["trace[58345632] 'count revisions from in-memory index tree' (duration: 174.664043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:28:07.770581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.26861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-15T07:28:07.770675Z","caller":"traceutil/trace.go:171","msg":"trace[1568062702] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1827; }","duration":"236.409603ms","start":"2026-04-15T07:28:07.534249Z","end":"2026-04-15T07:28:07.770659Z","steps":["trace[1568062702] 'range keys from in-memory index tree' (duration: 236.084484ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:28:07.770866Z","caller":"traceutil/trace.go:171","msg":"trace[373086413] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"184.774952ms","start":"2026-04-15T07:28:07.58606Z","end":"2026-04-15T07:28:07.770835Z","steps":["trace[373086413] 'process raft request' (duration: 134.901652ms)","trace[373086413] 'compare' (duration: 49.455929ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:28:08.23778Z","caller":"traceutil/trace.go:171","msg":"trace[1944313545] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"155.087314ms","start":"2026-04-15T07:28:08.082671Z","end":"2026-04-15T07:28:08.237759Z","steps":["trace[1944313545] 'process raft request' (duration: 154.915559ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:28:08.249143Z","caller":"traceutil/trace.go:171","msg":"trace[268455634] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"141.331175ms","start":"2026-04-15T07:28:08.107771Z","end":"2026-04-15T07:28:08.249102Z","steps":["trace[268455634] 'process raft request' (duration: 141.026406ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:28:19.951512Z","caller":"traceutil/trace.go:171","msg":"trace[330912869] linearizableReadLoop","detail":"{readStateIndex:2004; appliedIndex:2003; }","duration":"103.277886ms","start":"2026-04-15T07:28:19.848214Z","end":"2026-04-15T07:28:19.951492Z","steps":["trace[330912869] 'read index received' (duration: 91.214752ms)","trace[330912869] 'applied index is now lower than readState.Index' (duration: 12.062354ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:28:19.951649Z","caller":"traceutil/trace.go:171","msg":"trace[975567582] transaction","detail":"{read_only:false; response_revision:1933; number_of_response:1; }","duration":"144.063372ms","start":"2026-04-15T07:28:19.807542Z","end":"2026-04-15T07:28:19.951605Z","steps":["trace[975567582] 'process raft request' (duration: 131.952137ms)","trace[975567582] 'compare' (duration: 11.868438ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:28:19.951699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.477081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-15T07:28:19.951741Z","caller":"traceutil/trace.go:171","msg":"trace[1347452015] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1933; }","duration":"103.550913ms","start":"2026-04-15T07:28:19.848171Z","end":"2026-04-15T07:28:19.951721Z","steps":["trace[1347452015] 'agreement among raft nodes before linearized reading' (duration: 103.406379ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:28:23.235322Z","caller":"traceutil/trace.go:171","msg":"trace[37255610] transaction","detail":"{read_only:false; response_revision:1956; number_of_response:1; }","duration":"105.984328ms","start":"2026-04-15T07:28:23.129324Z","end":"2026-04-15T07:28:23.235308Z","steps":["trace[37255610] 'process raft request' (duration: 105.526096ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:28:46.129298Z","caller":"traceutil/trace.go:171","msg":"trace[478286055] transaction","detail":"{read_only:false; response_revision:2088; number_of_response:1; }","duration":"231.469749ms","start":"2026-04-15T07:28:45.897803Z","end":"2026-04-15T07:28:46.129273Z","steps":["trace[478286055] 'process raft request' (duration: 231.241933ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:28:46.143152Z","caller":"traceutil/trace.go:171","msg":"trace[1769157164] transaction","detail":"{read_only:false; response_revision:2089; number_of_response:1; }","duration":"108.154356ms","start":"2026-04-15T07:28:46.034966Z","end":"2026-04-15T07:28:46.14312Z","steps":["trace[1769157164] 'process raft request' (duration: 107.973381ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:28:46.757935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.834473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-15T07:28:46.758354Z","caller":"traceutil/trace.go:171","msg":"trace[1837534270] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2092; }","duration":"140.296814ms","start":"2026-04-15T07:28:46.618036Z","end":"2026-04-15T07:28:46.758333Z","steps":["trace[1837534270] 'range keys from in-memory index tree' (duration: 139.656359ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:28:47.267088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.660558ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-15T07:28:47.267202Z","caller":"traceutil/trace.go:171","msg":"trace[1290152374] linearizableReadLoop","detail":"{readStateIndex:2171; appliedIndex:2170; }","duration":"266.744836ms","start":"2026-04-15T07:28:47.000441Z","end":"2026-04-15T07:28:47.267186Z","steps":["trace[1290152374] 'read index received' (duration: 68.77925ms)","trace[1290152374] 'applied index is now lower than readState.Index' (duration: 197.964146ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:28:47.267393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.959082ms","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-15T07:28:47.267428Z","caller":"traceutil/trace.go:171","msg":"trace[1207088107] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2095; }","duration":"267.030303ms","start":"2026-04-15T07:28:47.000388Z","end":"2026-04-15T07:28:47.267418Z","steps":["trace[1207088107] 'agreement among raft nodes before linearized reading' (duration: 266.887199ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:28:47.267396Z","caller":"traceutil/trace.go:171","msg":"trace[514566797] transaction","detail":"{read_only:false; response_revision:2095; number_of_response:1; }","duration":"339.675121ms","start":"2026-04-15T07:28:46.92766Z","end":"2026-04-15T07:28:47.267335Z","steps":["trace[514566797] 'process raft request' (duration: 141.48865ms)","trace[514566797] 'compare' (duration: 197.35105ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:28:47.267627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.399527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-15T07:28:47.26776Z","caller":"traceutil/trace.go:171","msg":"trace[810827721] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2095; }","duration":"118.572691ms","start":"2026-04-15T07:28:47.149159Z","end":"2026-04-15T07:28:47.267732Z","steps":["trace[810827721] 'agreement among raft nodes before linearized reading' (duration: 118.163102ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:28:47.267958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:28:46.927642Z","time spent":"339.891486ms","remote":"127.0.0.1:50308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T07:28:47.523371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.326786ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-15T07:28:47.523477Z","caller":"traceutil/trace.go:171","msg":"trace[300573062] linearizableReadLoop","detail":"{readStateIndex:2172; appliedIndex:2171; }","duration":"180.761159ms","start":"2026-04-15T07:28:47.342698Z","end":"2026-04-15T07:28:47.523459Z","steps":["trace[300573062] 'read index received' (duration: 42.141636ms)","trace[300573062] 'applied index is now lower than readState.Index' (duration: 138.617632ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:28:47.523672Z","caller":"traceutil/trace.go:171","msg":"trace[238342505] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"251.588358ms","start":"2026-04-15T07:28:47.272054Z","end":"2026-04-15T07:28:47.523642Z","steps":["trace[238342505] 'process raft request' (duration: 112.890713ms)","trace[238342505] 'compare' (duration: 137.915676ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:28:47.523803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.107067ms","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-15T07:28:47.523847Z","caller":"traceutil/trace.go:171","msg":"trace[624419885] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2096; }","duration":"181.184648ms","start":"2026-04-15T07:28:47.342651Z","end":"2026-04-15T07:28:47.523835Z","steps":["trace[624419885] 'agreement among raft nodes before linearized reading' (duration: 181.019445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:30:09.531788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.746907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:30:09.531919Z","caller":"traceutil/trace.go:171","msg":"trace[828371416] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2652; }","duration":"161.974452ms","start":"2026-04-15T07:30:09.369915Z","end":"2026-04-15T07:30:09.53189Z","steps":["trace[828371416] 'range keys from in-memory index tree' (duration: 161.638644ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:30:15.110562Z","caller":"traceutil/trace.go:171","msg":"trace[973710443] transaction","detail":"{read_only:false; response_revision:2680; number_of_response:1; }","duration":"125.412598ms","start":"2026-04-15T07:30:14.98512Z","end":"2026-04-15T07:30:15.110532Z","steps":["trace[973710443] 'process raft request' (duration: 124.760395ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:23.768985Z","caller":"traceutil/trace.go:171","msg":"trace[309577323] transaction","detail":"{read_only:false; response_revision:3040; number_of_response:1; }","duration":"103.670392ms","start":"2026-04-15T07:31:23.665292Z","end":"2026-04-15T07:31:23.768962Z","steps":["trace[309577323] 'process raft request' (duration: 103.533607ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:31:23.771841Z","caller":"traceutil/trace.go:171","msg":"trace[424362236] transaction","detail":"{read_only:false; response_revision:3041; number_of_response:1; }","duration":"104.742997ms","start":"2026-04-15T07:31:23.66708Z","end":"2026-04-15T07:31:23.771823Z","steps":["trace[424362236] 'process raft request' (duration: 104.634244ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:33:55.645908Z","caller":"traceutil/trace.go:171","msg":"trace[991722250] transaction","detail":"{read_only:false; response_revision:4572; number_of_response:1; }","duration":"103.916508ms","start":"2026-04-15T07:33:55.541964Z","end":"2026-04-15T07:33:55.645881Z","steps":["trace[991722250] 'process raft request' (duration: 103.699762ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:34:01.110986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.714982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-978fdc5d7-f8vx9\" ","response":"range_response_count:1 size:11251"} {"level":"info","ts":"2026-04-15T07:34:01.111284Z","caller":"traceutil/trace.go:171","msg":"trace[198499509] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-978fdc5d7-f8vx9; range_end:; response_count:1; response_revision:4605; }","duration":"121.044559ms","start":"2026-04-15T07:34:00.99021Z","end":"2026-04-15T07:34:01.111254Z","steps":["trace[198499509] 'range keys from in-memory index tree' (duration: 120.527367ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:34:01.111251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.821257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-04-15T07:34:01.111367Z","caller":"traceutil/trace.go:171","msg":"trace[322977827] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4605; }","duration":"114.983592ms","start":"2026-04-15T07:34:00.996354Z","end":"2026-04-15T07:34:01.111338Z","steps":["trace[322977827] 'range keys from in-memory index tree' (duration: 114.446277ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:34:01.24668Z","caller":"traceutil/trace.go:171","msg":"trace[1114197679] linearizableReadLoop","detail":"{readStateIndex:4777; appliedIndex:4776; }","duration":"160.989406ms","start":"2026-04-15T07:34:01.085653Z","end":"2026-04-15T07:34:01.246642Z","steps":["trace[1114197679] 'read index received' (duration: 160.822632ms)","trace[1114197679] 'applied index is now lower than readState.Index' (duration: 165.114µs)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:34:01.246757Z","caller":"traceutil/trace.go:171","msg":"trace[1099554218] transaction","detail":"{read_only:false; response_revision:4606; number_of_response:1; }","duration":"193.368187ms","start":"2026-04-15T07:34:01.053351Z","end":"2026-04-15T07:34:01.246719Z","steps":["trace[1099554218] 'process raft request' (duration: 193.018568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:34:01.247161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.461347ms","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-15T07:34:01.247764Z","caller":"traceutil/trace.go:171","msg":"trace[949068002] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4606; }","duration":"162.141544ms","start":"2026-04-15T07:34:01.085586Z","end":"2026-04-15T07:34:01.247728Z","steps":["trace[949068002] 'agreement among raft nodes before linearized reading' (duration: 161.203552ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:34:01.343708Z","caller":"traceutil/trace.go:171","msg":"trace[1542100667] transaction","detail":"{read_only:false; response_revision:4607; number_of_response:1; }","duration":"216.138214ms","start":"2026-04-15T07:34:01.127539Z","end":"2026-04-15T07:34:01.343677Z","steps":["trace[1542100667] 'process raft request' (duration: 215.925508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:34:01.34376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.782879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-f7702baf-8a4f-4c96-8be1-68ef02a65e83\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-04-15T07:34:01.343821Z","caller":"traceutil/trace.go:171","msg":"trace[1481241646] range","detail":"{range_begin:/registry/persistentvolumes/pvc-f7702baf-8a4f-4c96-8be1-68ef02a65e83; range_end:; response_count:1; response_revision:4607; }","duration":"227.906833ms","start":"2026-04-15T07:34:01.1159Z","end":"2026-04-15T07:34:01.343807Z","steps":["trace[1481241646] 'agreement among raft nodes before linearized reading' (duration: 227.715437ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:34:01.34398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.392284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:34:01.344019Z","caller":"traceutil/trace.go:171","msg":"trace[196698879] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:4607; }","duration":"109.494268ms","start":"2026-04-15T07:34:01.234516Z","end":"2026-04-15T07:34:01.34401Z","steps":["trace[196698879] 'agreement among raft nodes before linearized reading' (duration: 109.380885ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:34:01.344076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.445716ms","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-15T07:34:01.344097Z","caller":"traceutil/trace.go:171","msg":"trace[49920457] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4607; }","duration":"208.490497ms","start":"2026-04-15T07:34:01.135601Z","end":"2026-04-15T07:34:01.344091Z","steps":["trace[49920457] 'agreement among raft nodes before linearized reading' (duration: 208.424986ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:34:01.516424Z","caller":"traceutil/trace.go:171","msg":"trace[1001929884] transaction","detail":"{read_only:false; response_revision:4608; number_of_response:1; }","duration":"262.824445ms","start":"2026-04-15T07:34:01.253568Z","end":"2026-04-15T07:34:01.516393Z","steps":["trace[1001929884] 'process raft request' (duration: 236.01139ms)","trace[1001929884] 'compare' (duration: 26.384865ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:34:01.517324Z","caller":"traceutil/trace.go:171","msg":"trace[1153648911] transaction","detail":"{read_only:false; response_revision:4609; number_of_response:1; }","duration":"246.25485ms","start":"2026-04-15T07:34:01.271027Z","end":"2026-04-15T07:34:01.517282Z","steps":["trace[1153648911] 'process raft request' (duration: 245.311907ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:34:01.517788Z","caller":"traceutil/trace.go:171","msg":"trace[390674216] linearizableReadLoop","detail":"{readStateIndex:4782; appliedIndex:4778; }","duration":"169.674328ms","start":"2026-04-15T07:34:01.348087Z","end":"2026-04-15T07:34:01.517761Z","steps":["trace[390674216] 'read index received' (duration: 141.51071ms)","trace[390674216] 'applied index is now lower than readState.Index' (duration: 28.162718ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:34:01.517843Z","caller":"traceutil/trace.go:171","msg":"trace[1520217737] transaction","detail":"{read_only:false; response_revision:4610; number_of_response:1; }","duration":"236.515403ms","start":"2026-04-15T07:34:01.281314Z","end":"2026-04-15T07:34:01.51783Z","steps":["trace[1520217737] 'process raft request' (duration: 235.275142ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:34:01.517924Z","caller":"traceutil/trace.go:171","msg":"trace[637164913] transaction","detail":"{read_only:false; response_revision:4611; number_of_response:1; }","duration":"203.600698ms","start":"2026-04-15T07:34:01.314287Z","end":"2026-04-15T07:34:01.517888Z","steps":["trace[637164913] 'process raft request' (duration: 203.419584ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:34:01.518139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.006766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12972"} {"level":"info","ts":"2026-04-15T07:34:01.51818Z","caller":"traceutil/trace.go:171","msg":"trace[532338503] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4611; }","duration":"170.109509ms","start":"2026-04-15T07:34:01.34806Z","end":"2026-04-15T07:34:01.518169Z","steps":["trace[532338503] 'agreement among raft nodes before linearized reading' (duration: 169.804702ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:34:01.68946Z","caller":"traceutil/trace.go:171","msg":"trace[236045273] transaction","detail":"{read_only:false; response_revision:4614; number_of_response:1; }","duration":"340.363411ms","start":"2026-04-15T07:34:01.349077Z","end":"2026-04-15T07:34:01.68944Z","steps":["trace[236045273] 'process raft request' (duration: 340.302339ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:34:01.689637Z","caller":"traceutil/trace.go:171","msg":"trace[1540507406] transaction","detail":"{read_only:false; response_revision:4612; number_of_response:1; }","duration":"340.958695ms","start":"2026-04-15T07:34:01.348665Z","end":"2026-04-15T07:34:01.689624Z","steps":["trace[1540507406] 'process raft request' (duration: 340.503534ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:34:01.689685Z","caller":"traceutil/trace.go:171","msg":"trace[748846210] transaction","detail":"{read_only:false; response_revision:4613; number_of_response:1; }","duration":"340.776491ms","start":"2026-04-15T07:34:01.348894Z","end":"2026-04-15T07:34:01.689671Z","steps":["trace[748846210] 'process raft request' (duration: 340.401982ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:34:01.689712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:34:01.348649Z","time spent":"341.027807ms","remote":"127.0.0.1:50206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":991,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T07:34:01.689639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:34:01.349066Z","time spent":"340.471354ms","remote":"127.0.0.1:50316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1407,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T07:34:01.689734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:34:01.348873Z","time spent":"340.834662ms","remote":"127.0.0.1:50308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T07:34:01.744806Z","caller":"traceutil/trace.go:171","msg":"trace[249218323] transaction","detail":"{read_only:false; response_revision:4615; number_of_response:1; }","duration":"215.243942ms","start":"2026-04-15T07:34:01.529529Z","end":"2026-04-15T07:34:01.744773Z","steps":["trace[249218323] 'process raft request' (duration: 214.748079ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:34:01.7448Z","caller":"traceutil/trace.go:171","msg":"trace[1416367834] transaction","detail":"{read_only:false; response_revision:4616; number_of_response:1; }","duration":"174.502176ms","start":"2026-04-15T07:34:01.570257Z","end":"2026-04-15T07:34:01.744759Z","steps":["trace[1416367834] 'process raft request' (duration: 174.25403ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:34:02.215936Z","caller":"traceutil/trace.go:171","msg":"trace[1892877316] transaction","detail":"{read_only:false; response_revision:4625; number_of_response:1; }","duration":"131.00277ms","start":"2026-04-15T07:34:02.084892Z","end":"2026-04-15T07:34:02.215895Z","steps":["trace[1892877316] 'process raft request' (duration: 116.419704ms)","trace[1892877316] 'compare' (duration: 14.435152ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:34:02.283425Z","caller":"traceutil/trace.go:171","msg":"trace[1024393071] transaction","detail":"{read_only:false; response_revision:4626; number_of_response:1; }","duration":"198.503968ms","start":"2026-04-15T07:34:02.084892Z","end":"2026-04-15T07:34:02.283396Z","steps":["trace[1024393071] 'process raft request' (duration: 198.269402ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:34:02.283734Z","caller":"traceutil/trace.go:171","msg":"trace[253784396] transaction","detail":"{read_only:false; response_revision:4627; number_of_response:1; }","duration":"198.562508ms","start":"2026-04-15T07:34:02.085107Z","end":"2026-04-15T07:34:02.283669Z","steps":["trace[253784396] 'process raft request' (duration: 198.2327ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:34:02.28377Z","caller":"traceutil/trace.go:171","msg":"trace[970658991] transaction","detail":"{read_only:false; response_revision:4628; number_of_response:1; }","duration":"198.482836ms","start":"2026-04-15T07:34:02.085272Z","end":"2026-04-15T07:34:02.283755Z","steps":["trace[970658991] 'process raft request' (duration: 198.291172ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:34:02.283746Z","caller":"traceutil/trace.go:171","msg":"trace[1701303404] linearizableReadLoop","detail":"{readStateIndex:4799; appliedIndex:4795; }","duration":"198.269501ms","start":"2026-04-15T07:34:02.085447Z","end":"2026-04-15T07:34:02.283716Z","steps":["trace[1701303404] 'read index received' (duration: 115.88501ms)","trace[1701303404] 'applied index is now lower than readState.Index' (duration: 82.383081ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:34:02.283988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.507337ms","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-04-15T07:34:02.284048Z","caller":"traceutil/trace.go:171","msg":"trace[1222001821] 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:4628; }","duration":"198.62375ms","start":"2026-04-15T07:34:02.085408Z","end":"2026-04-15T07:34:02.284032Z","steps":["trace[1222001821] 'agreement among raft nodes before linearized reading' (duration: 198.404855ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:34:19.242343Z","caller":"traceutil/trace.go:171","msg":"trace[1846960108] linearizableReadLoop","detail":"{readStateIndex:5027; appliedIndex:5026; }","duration":"308.940037ms","start":"2026-04-15T07:34:18.933372Z","end":"2026-04-15T07:34:19.242312Z","steps":["trace[1846960108] 'read index received' (duration: 308.65506ms)","trace[1846960108] 'applied index is now lower than readState.Index' (duration: 283.597µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:34:19.242851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.726774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:34:19.242924Z","caller":"traceutil/trace.go:171","msg":"trace[1688794049] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:4849; }","duration":"249.816296ms","start":"2026-04-15T07:34:18.993088Z","end":"2026-04-15T07:34:19.242904Z","steps":["trace[1688794049] 'agreement among raft nodes before linearized reading' (duration: 249.679263ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:34:19.243101Z","caller":"traceutil/trace.go:171","msg":"trace[1318529130] transaction","detail":"{read_only:false; response_revision:4849; number_of_response:1; }","duration":"312.330938ms","start":"2026-04-15T07:34:18.930746Z","end":"2026-04-15T07:34:19.243077Z","steps":["trace[1318529130] 'process raft request' (duration: 311.378786ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:34:19.243287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:34:18.93073Z","time spent":"312.474111ms","remote":"127.0.0.1:50308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T07:34:19.243326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.100787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-111a59ed-9463-4c7f-8eee-48dc194f40be\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-04-15T07:34:19.245361Z","caller":"traceutil/trace.go:171","msg":"trace[1215055694] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-111a59ed-9463-4c7f-8eee-48dc194f40be; range_end:; response_count:1; response_revision:4849; }","duration":"198.178467ms","start":"2026-04-15T07:34:19.047162Z","end":"2026-04-15T07:34:19.24534Z","steps":["trace[1215055694] 'agreement among raft nodes before linearized reading' (duration: 196.124627ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:34:19.242841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.436729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-04-15T07:34:19.24584Z","caller":"traceutil/trace.go:171","msg":"trace[800564673] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:4849; }","duration":"312.493972ms","start":"2026-04-15T07:34:18.933331Z","end":"2026-04-15T07:34:19.245825Z","steps":["trace[800564673] 'agreement among raft nodes before linearized reading' (duration: 309.240864ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:34:19.245908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:34:18.93331Z","time spent":"312.581934ms","remote":"127.0.0.1:59634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5675,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-04-15T07:35:10.253432Z","caller":"traceutil/trace.go:171","msg":"trace[1221534656] linearizableReadLoop","detail":"{readStateIndex:5460; appliedIndex:5459; }","duration":"140.664858ms","start":"2026-04-15T07:35:10.112717Z","end":"2026-04-15T07:35:10.253382Z","steps":["trace[1221534656] 'read index received' (duration: 59.311325ms)","trace[1221534656] 'applied index is now lower than readState.Index' (duration: 81.351653ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:35:10.253513Z","caller":"traceutil/trace.go:171","msg":"trace[1568104253] transaction","detail":"{read_only:false; response_revision:5270; number_of_response:1; }","duration":"143.3555ms","start":"2026-04-15T07:35:10.110113Z","end":"2026-04-15T07:35:10.253468Z","steps":["trace[1568104253] 'process raft request' (duration: 114.183929ms)","trace[1568104253] 'compare' (duration: 28.871014ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:35:10.25377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.019606ms","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-15T07:35:10.254769Z","caller":"traceutil/trace.go:171","msg":"trace[2043075187] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5270; }","duration":"141.909506ms","start":"2026-04-15T07:35:10.112679Z","end":"2026-04-15T07:35:10.254588Z","steps":["trace[2043075187] 'agreement among raft nodes before linearized reading' (duration: 140.918784ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:35:55.062966Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2892} {"level":"info","ts":"2026-04-15T07:35:55.172392Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2892,"took":"107.715786ms","hash":524973500,"current-db-size-bytes":52457472,"current-db-size":"52 MB","current-db-size-in-use-bytes":29089792,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-15T07:35:55.17246Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":524973500,"revision":2892,"compact-revision":-1} {"level":"info","ts":"2026-04-15T07:40:55.070237Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5610} {"level":"info","ts":"2026-04-15T07:40:55.149884Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5610,"took":"78.101801ms","hash":1311195053,"current-db-size-bytes":52457472,"current-db-size":"52 MB","current-db-size-in-use-bytes":16711680,"current-db-size-in-use":"17 MB"} {"level":"info","ts":"2026-04-15T07:40:55.149945Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1311195053,"revision":5610,"compact-revision":2892}