{"level":"warn","ts":"2026-04-07T00:08:39.848977Z","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-07T00:08:39.849126Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.186: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.186:2380","--initial-cluster=instance=https://199.19.213.186:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.186:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.186: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-07T00:08:39.849248Z","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-07T00:08:39.849264Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.186:2380"]} {"level":"info","ts":"2026-04-07T00:08:39.849293Z","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-07T00:08:39.850335Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.186:2379"]} {"level":"info","ts":"2026-04-07T00:08:39.850435Z","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.186:2380"],"listen-peer-urls":["https://199.19.213.186:2380"],"advertise-client-urls":["https://199.19.213.186:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.186:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.186: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-07T00:08:39.865602Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"14.837232ms"} {"level":"info","ts":"2026-04-07T00:08:39.874842Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"22478416d949d47d","cluster-id":"568bb29601528c07"} {"level":"info","ts":"2026-04-07T00:08:39.874983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"22478416d949d47d switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T00:08:39.875031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"22478416d949d47d became follower at term 0"} {"level":"info","ts":"2026-04-07T00:08:39.875059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 22478416d949d47d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T00:08:39.875074Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"22478416d949d47d became follower at term 1"} {"level":"info","ts":"2026-04-07T00:08:39.875141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"22478416d949d47d switched to configuration voters=(2470088154305647741)"} {"level":"warn","ts":"2026-04-07T00:08:39.88303Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T00:08:39.88441Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T00:08:39.885483Z","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-07T00:08:39.887831Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"22478416d949d47d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T00:08:39.888111Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"22478416d949d47d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T00:08:39.888261Z","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-07T00:08:39.892376Z","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-07T00:08:39.892427Z","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-07T00:08:39.895931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"22478416d949d47d switched to configuration voters=(2470088154305647741)"} {"level":"info","ts":"2026-04-07T00:08:39.896108Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"568bb29601528c07","local-member-id":"22478416d949d47d","added-peer-id":"22478416d949d47d","added-peer-peer-urls":["https://199.19.213.186:2380"]} {"level":"info","ts":"2026-04-07T00:08:39.896442Z","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-07T00:08:39.896578Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.186:2380"} {"level":"info","ts":"2026-04-07T00:08:39.896637Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.186:2380"} {"level":"info","ts":"2026-04-07T00:08:39.896873Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"22478416d949d47d","initial-advertise-peer-urls":["https://199.19.213.186:2380"],"listen-peer-urls":["https://199.19.213.186:2380"],"advertise-client-urls":["https://199.19.213.186:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.186:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T00:08:39.896956Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T00:08:40.475717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"22478416d949d47d is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T00:08:40.475804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"22478416d949d47d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T00:08:40.476053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"22478416d949d47d received MsgPreVoteResp from 22478416d949d47d at term 1"} {"level":"info","ts":"2026-04-07T00:08:40.476082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"22478416d949d47d became candidate at term 2"} {"level":"info","ts":"2026-04-07T00:08:40.476105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"22478416d949d47d received MsgVoteResp from 22478416d949d47d at term 2"} {"level":"info","ts":"2026-04-07T00:08:40.476119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"22478416d949d47d became leader at term 2"} {"level":"info","ts":"2026-04-07T00:08:40.476133Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 22478416d949d47d elected leader 22478416d949d47d at term 2"} {"level":"info","ts":"2026-04-07T00:08:40.477095Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"22478416d949d47d","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.186:2379]}","request-path":"/0/members/22478416d949d47d/attributes","cluster-id":"568bb29601528c07","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T00:08:40.477544Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:08:40.478404Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T00:08:40.478959Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T00:08:40.479227Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T00:08:40.479256Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T00:08:40.479305Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"568bb29601528c07","local-member-id":"22478416d949d47d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:08:40.479408Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:08:40.479444Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:08:40.481653Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.186:2379"} {"level":"info","ts":"2026-04-07T00:08:40.482458Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T00:08:45.246441Z","caller":"traceutil/trace.go:171","msg":"trace[1032293490] transaction","detail":"{read_only:false; response_revision:248; number_of_response:1; }","duration":"211.439279ms","start":"2026-04-07T00:08:45.034969Z","end":"2026-04-07T00:08:45.246408Z","steps":["trace[1032293490] 'process raft request' (duration: 211.1764ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:09:12.304612Z","caller":"traceutil/trace.go:171","msg":"trace[2064765626] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"103.578502ms","start":"2026-04-07T00:09:12.201007Z","end":"2026-04-07T00:09:12.304585Z","steps":["trace[2064765626] 'process raft request' (duration: 103.361956ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:09:12.304649Z","caller":"traceutil/trace.go:171","msg":"trace[1206426910] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"110.906406ms","start":"2026-04-07T00:09:12.19368Z","end":"2026-04-07T00:09:12.304586Z","steps":["trace[1206426910] 'process raft request' (duration: 108.694539ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:09:18.244205Z","caller":"traceutil/trace.go:171","msg":"trace[1776008852] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"180.617799ms","start":"2026-04-07T00:09:18.063557Z","end":"2026-04-07T00:09:18.244175Z","steps":["trace[1776008852] 'process raft request' (duration: 177.67944ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:09:18.891436Z","caller":"traceutil/trace.go:171","msg":"trace[780462162] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"105.231851ms","start":"2026-04-07T00:09:18.786174Z","end":"2026-04-07T00:09:18.891406Z","steps":["trace[780462162] 'process raft request' (duration: 104.584031ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:09:19.288344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.113686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:09:19.288973Z","caller":"traceutil/trace.go:171","msg":"trace[1808999265] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:617; }","duration":"382.824428ms","start":"2026-04-07T00:09:18.906122Z","end":"2026-04-07T00:09:19.288946Z","steps":["trace[1808999265] 'range keys from in-memory index tree' (duration: 381.973352ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:09:19.289181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:09:18.906098Z","time spent":"383.042625ms","remote":"127.0.0.1:47942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T00:09:19.327353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.696967ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-07T00:09:19.327651Z","caller":"traceutil/trace.go:171","msg":"trace[504960963] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:635; }","duration":"372.351869ms","start":"2026-04-07T00:09:18.955278Z","end":"2026-04-07T00:09:19.32763Z","steps":["trace[504960963] 'read index received' (duration: 174.23887ms)","trace[504960963] 'applied index is now lower than readState.Index' (duration: 198.112049ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:09:19.327985Z","caller":"traceutil/trace.go:171","msg":"trace[1214643434] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"380.859397ms","start":"2026-04-07T00:09:18.947069Z","end":"2026-04-07T00:09:19.327928Z","steps":["trace[1214643434] 'process raft request' (duration: 380.387763ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:09:19.328011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.754521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-57lzj\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-07T00:09:19.328066Z","caller":"traceutil/trace.go:171","msg":"trace[1723367688] range","detail":"{range_begin:/registry/pods/kube-system/cilium-57lzj; range_end:; response_count:1; response_revision:618; }","duration":"372.812464ms","start":"2026-04-07T00:09:18.955238Z","end":"2026-04-07T00:09:19.32805Z","steps":["trace[1723367688] 'agreement among raft nodes before linearized reading' (duration: 372.467294ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:09:19.328121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:09:18.955134Z","time spent":"372.974429ms","remote":"127.0.0.1:48150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-57lzj\" "} {"level":"warn","ts":"2026-04-07T00:09:19.328734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:09:18.947028Z","time spent":"381.092314ms","remote":"127.0.0.1:48462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T00:10:50.545406Z","caller":"traceutil/trace.go:171","msg":"trace[2299402] linearizableReadLoop","detail":"{readStateIndex:1914; appliedIndex:1913; }","duration":"225.493228ms","start":"2026-04-07T00:10:50.319888Z","end":"2026-04-07T00:10:50.545381Z","steps":["trace[2299402] 'read index received' (duration: 224.808239ms)","trace[2299402] 'applied index is now lower than readState.Index' (duration: 683.539µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:10:50.545752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.833766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-07T00:10:50.545796Z","caller":"traceutil/trace.go:171","msg":"trace[1503586966] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1846; }","duration":"225.950029ms","start":"2026-04-07T00:10:50.319833Z","end":"2026-04-07T00:10:50.545783Z","steps":["trace[1503586966] 'agreement among raft nodes before linearized reading' (duration: 225.767265ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:10:50.545584Z","caller":"traceutil/trace.go:171","msg":"trace[1717772395] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"315.040229ms","start":"2026-04-07T00:10:50.230493Z","end":"2026-04-07T00:10:50.545534Z","steps":["trace[1717772395] 'process raft request' (duration: 314.232517ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:10:50.545909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.478417ms","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-07T00:10:50.545952Z","caller":"traceutil/trace.go:171","msg":"trace[165813702] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1846; }","duration":"154.56132ms","start":"2026-04-07T00:10:50.39138Z","end":"2026-04-07T00:10:50.545941Z","steps":["trace[165813702] 'agreement among raft nodes before linearized reading' (duration: 154.446437ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:10:50.546014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.957658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9058835a-bdcb-4549-9bcb-33d6b11a732e\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-07T00:10:50.546099Z","caller":"traceutil/trace.go:171","msg":"trace[1643895100] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9058835a-bdcb-4549-9bcb-33d6b11a732e; range_end:; response_count:1; response_revision:1846; }","duration":"105.092992ms","start":"2026-04-07T00:10:50.440988Z","end":"2026-04-07T00:10:50.546081Z","steps":["trace[1643895100] 'agreement among raft nodes before linearized reading' (duration: 104.858085ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:10:50.547214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:10:50.230476Z","time spent":"316.264372ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":967,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:10:50.739634Z","caller":"traceutil/trace.go:171","msg":"trace[954128910] linearizableReadLoop","detail":"{readStateIndex:1916; appliedIndex:1914; }","duration":"119.037299ms","start":"2026-04-07T00:10:50.620575Z","end":"2026-04-07T00:10:50.739613Z","steps":["trace[954128910] 'read index received' (duration: 5.14471ms)","trace[954128910] 'applied index is now lower than readState.Index' (duration: 113.891539ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:10:50.739768Z","caller":"traceutil/trace.go:171","msg":"trace[250665651] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"186.143643ms","start":"2026-04-07T00:10:50.553587Z","end":"2026-04-07T00:10:50.73973Z","steps":["trace[250665651] 'process raft request' (duration: 185.882416ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:10:50.739781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.209043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:10:50.739864Z","caller":"traceutil/trace.go:171","msg":"trace[331053021] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1848; }","duration":"119.350278ms","start":"2026-04-07T00:10:50.620502Z","end":"2026-04-07T00:10:50.739852Z","steps":["trace[331053021] 'agreement among raft nodes before linearized reading' (duration: 119.226194ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:10:51.164028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.921716ms","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-07T00:10:51.164123Z","caller":"traceutil/trace.go:171","msg":"trace[291956313] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1849; }","duration":"246.08012ms","start":"2026-04-07T00:10:50.918026Z","end":"2026-04-07T00:10:51.164106Z","steps":["trace[291956313] 'range keys from in-memory index tree' (duration: 245.648359ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:10:51.164028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.791186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T00:10:51.164187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.183789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-07T00:10:51.164248Z","caller":"traceutil/trace.go:171","msg":"trace[81469303] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1849; }","duration":"258.064864ms","start":"2026-04-07T00:10:50.906158Z","end":"2026-04-07T00:10:51.164223Z","steps":["trace[81469303] 'range keys from in-memory index tree' (duration: 257.636452ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:10:51.164305Z","caller":"traceutil/trace.go:171","msg":"trace[1695293665] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1849; }","duration":"126.384015ms","start":"2026-04-07T00:10:51.037883Z","end":"2026-04-07T00:10:51.164267Z","steps":["trace[1695293665] 'range keys from in-memory index tree' (duration: 125.786418ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:11:25.268478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.71727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:528"} {"level":"info","ts":"2026-04-07T00:11:25.26857Z","caller":"traceutil/trace.go:171","msg":"trace[2010001665] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2092; }","duration":"130.864584ms","start":"2026-04-07T00:11:25.137688Z","end":"2026-04-07T00:11:25.268553Z","steps":["trace[2010001665] 'range keys from in-memory index tree' (duration: 130.429902ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:11:25.620257Z","caller":"traceutil/trace.go:171","msg":"trace[487604080] linearizableReadLoop","detail":"{readStateIndex:2169; appliedIndex:2168; }","duration":"255.806611ms","start":"2026-04-07T00:11:25.36442Z","end":"2026-04-07T00:11:25.620226Z","steps":["trace[487604080] 'read index received' (duration: 255.427171ms)","trace[487604080] 'applied index is now lower than readState.Index' (duration: 377.97µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:11:25.620378Z","caller":"traceutil/trace.go:171","msg":"trace[181900104] transaction","detail":"{read_only:false; response_revision:2094; number_of_response:1; }","duration":"281.840027ms","start":"2026-04-07T00:11:25.338484Z","end":"2026-04-07T00:11:25.620324Z","steps":["trace[181900104] 'process raft request' (duration: 281.518778ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:11:25.620668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.126075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:11:25.620736Z","caller":"traceutil/trace.go:171","msg":"trace[374900336] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:2094; }","duration":"241.222417ms","start":"2026-04-07T00:11:25.379497Z","end":"2026-04-07T00:11:25.62072Z","steps":["trace[374900336] 'agreement among raft nodes before linearized reading' (duration: 241.084624ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:11:25.620828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.405937ms","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-07T00:11:25.6209Z","caller":"traceutil/trace.go:171","msg":"trace[60837575] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2094; }","duration":"256.51883ms","start":"2026-04-07T00:11:25.364369Z","end":"2026-04-07T00:11:25.620888Z","steps":["trace[60837575] 'agreement among raft nodes before linearized reading' (duration: 256.017796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:11:25.622092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.76572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-07T00:11:25.622321Z","caller":"traceutil/trace.go:171","msg":"trace[367450681] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2094; }","duration":"145.040667ms","start":"2026-04-07T00:11:25.477194Z","end":"2026-04-07T00:11:25.622235Z","steps":["trace[367450681] 'agreement among raft nodes before linearized reading' (duration: 143.491046ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:11:25.835562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.588351ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T00:11:25.835683Z","caller":"traceutil/trace.go:171","msg":"trace[664633145] linearizableReadLoop","detail":"{readStateIndex:2172; appliedIndex:2171; }","duration":"160.761581ms","start":"2026-04-07T00:11:25.674903Z","end":"2026-04-07T00:11:25.835665Z","steps":["trace[664633145] 'read index received' (duration: 41.881442ms)","trace[664633145] 'applied index is now lower than readState.Index' (duration: 118.879029ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:11:25.835883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.723084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:11:25.835894Z","caller":"traceutil/trace.go:171","msg":"trace[1444855444] transaction","detail":"{read_only:false; response_revision:2097; number_of_response:1; }","duration":"170.015775ms","start":"2026-04-07T00:11:25.665839Z","end":"2026-04-07T00:11:25.835855Z","steps":["trace[1444855444] 'process raft request' (duration: 51.053774ms)","trace[1444855444] 'compare' (duration: 118.441767ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:11:25.83593Z","caller":"traceutil/trace.go:171","msg":"trace[275274759] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:2097; }","duration":"129.814616ms","start":"2026-04-07T00:11:25.706101Z","end":"2026-04-07T00:11:25.835915Z","steps":["trace[275274759] 'agreement among raft nodes before linearized reading' (duration: 129.733794ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:11:25.836438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.51502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"} {"level":"info","ts":"2026-04-07T00:11:25.836507Z","caller":"traceutil/trace.go:171","msg":"trace[1075203837] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2097; }","duration":"161.649274ms","start":"2026-04-07T00:11:25.674839Z","end":"2026-04-07T00:11:25.836488Z","steps":["trace[1075203837] 'agreement among raft nodes before linearized reading' (duration: 160.924585ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:11:26.073048Z","caller":"traceutil/trace.go:171","msg":"trace[430751967] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"235.68251ms","start":"2026-04-07T00:11:25.837338Z","end":"2026-04-07T00:11:26.07302Z","steps":["trace[430751967] 'process raft request' (duration: 144.851181ms)","trace[430751967] 'compare' (duration: 90.534101ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:11:26.073324Z","caller":"traceutil/trace.go:171","msg":"trace[115185906] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"232.376974ms","start":"2026-04-07T00:11:25.840907Z","end":"2026-04-07T00:11:26.073284Z","steps":["trace[115185906] 'process raft request' (duration: 232.034575ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:11:26.275486Z","caller":"traceutil/trace.go:171","msg":"trace[1618116775] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"108.949015ms","start":"2026-04-07T00:11:26.166508Z","end":"2026-04-07T00:11:26.275457Z","steps":["trace[1618116775] 'process raft request' (duration: 108.518904ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:12:31.07289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.78417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:12:31.073545Z","caller":"traceutil/trace.go:171","msg":"trace[761919394] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2547; }","duration":"166.469147ms","start":"2026-04-07T00:12:30.907056Z","end":"2026-04-07T00:12:31.073525Z","steps":["trace[761919394] 'range keys from in-memory index tree' (duration: 165.743329ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:15:04.679698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.23485ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-07T00:15:04.679886Z","caller":"traceutil/trace.go:171","msg":"trace[579254899] transaction","detail":"{read_only:false; response_revision:3392; number_of_response:1; }","duration":"138.71006ms","start":"2026-04-07T00:15:04.541098Z","end":"2026-04-07T00:15:04.679808Z","steps":["trace[579254899] 'process raft request' (duration: 31.287675ms)","trace[579254899] 'compare' (duration: 106.944553ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:17:09.618354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.656425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3465"} {"level":"info","ts":"2026-04-07T00:17:09.618432Z","caller":"traceutil/trace.go:171","msg":"trace[1079638880] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4781; }","duration":"112.741567ms","start":"2026-04-07T00:17:09.505673Z","end":"2026-04-07T00:17:09.618415Z","steps":["trace[1079638880] 'range keys from in-memory index tree' (duration: 112.281644ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:17:09.763064Z","caller":"traceutil/trace.go:171","msg":"trace[1732800563] transaction","detail":"{read_only:false; response_revision:4784; number_of_response:1; }","duration":"134.396281ms","start":"2026-04-07T00:17:09.628626Z","end":"2026-04-07T00:17:09.763023Z","steps":["trace[1732800563] 'process raft request' (duration: 92.044578ms)","trace[1732800563] 'compare' (duration: 42.065605ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:17:09.763508Z","caller":"traceutil/trace.go:171","msg":"trace[717117362] linearizableReadLoop","detail":"{readStateIndex:4964; appliedIndex:4963; }","duration":"134.565836ms","start":"2026-04-07T00:17:09.628903Z","end":"2026-04-07T00:17:09.763468Z","steps":["trace[717117362] 'read index received' (duration: 91.784481ms)","trace[717117362] 'applied index is now lower than readState.Index' (duration: 42.493347ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:17:09.763446Z","caller":"traceutil/trace.go:171","msg":"trace[1818223449] transaction","detail":"{read_only:false; response_revision:4785; number_of_response:1; }","duration":"132.716375ms","start":"2026-04-07T00:17:09.630715Z","end":"2026-04-07T00:17:09.763432Z","steps":["trace[1818223449] 'process raft request' (duration: 132.255333ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:17:09.763613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.665289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3465"} {"level":"info","ts":"2026-04-07T00:17:09.76376Z","caller":"traceutil/trace.go:171","msg":"trace[285529165] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4784; }","duration":"134.811423ms","start":"2026-04-07T00:17:09.628874Z","end":"2026-04-07T00:17:09.763685Z","steps":["trace[285529165] 'agreement among raft nodes before linearized reading' (duration: 134.483594ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:17:21.746969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.254978ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T00:17:21.747088Z","caller":"traceutil/trace.go:171","msg":"trace[416193814] linearizableReadLoop","detail":"{readStateIndex:5133; appliedIndex:5132; }","duration":"277.268289ms","start":"2026-04-07T00:17:21.469802Z","end":"2026-04-07T00:17:21.747071Z","steps":["trace[416193814] 'read index received' (duration: 89.689852ms)","trace[416193814] 'applied index is now lower than readState.Index' (duration: 187.576797ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:17:21.747161Z","caller":"traceutil/trace.go:171","msg":"trace[2091862208] transaction","detail":"{read_only:false; response_revision:4947; number_of_response:1; }","duration":"278.764739ms","start":"2026-04-07T00:17:21.468384Z","end":"2026-04-07T00:17:21.747149Z","steps":["trace[2091862208] 'process raft request' (duration: 91.211683ms)","trace[2091862208] 'compare' (duration: 187.070033ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:17:21.747444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.632799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"} {"level":"info","ts":"2026-04-07T00:17:21.747504Z","caller":"traceutil/trace.go:171","msg":"trace[559671330] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4947; }","duration":"277.731832ms","start":"2026-04-07T00:17:21.469758Z","end":"2026-04-07T00:17:21.74749Z","steps":["trace[559671330] 'agreement among raft nodes before linearized reading' (duration: 277.548717ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:17:21.753371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.753852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-07T00:17:21.753431Z","caller":"traceutil/trace.go:171","msg":"trace[737001483] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4948; }","duration":"247.837524ms","start":"2026-04-07T00:17:21.505577Z","end":"2026-04-07T00:17:21.753415Z","steps":["trace[737001483] 'agreement among raft nodes before linearized reading' (duration: 247.66534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:17:21.753478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.083403ms","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-07T00:17:21.753561Z","caller":"traceutil/trace.go:171","msg":"trace[239456975] 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:4948; }","duration":"221.200816ms","start":"2026-04-07T00:17:21.532341Z","end":"2026-04-07T00:17:21.753542Z","steps":["trace[239456975] 'agreement among raft nodes before linearized reading' (duration: 220.953539ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:17:22.56614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.093705ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T00:17:22.566689Z","caller":"traceutil/trace.go:171","msg":"trace[390547486] transaction","detail":"{read_only:false; response_revision:4964; number_of_response:1; }","duration":"616.112664ms","start":"2026-04-07T00:17:21.950544Z","end":"2026-04-07T00:17:22.566657Z","steps":["trace[390547486] 'process raft request' (duration: 21.923819ms)","trace[390547486] 'compare' (duration: 592.895709ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:17:22.566803Z","caller":"traceutil/trace.go:171","msg":"trace[2061222148] linearizableReadLoop","detail":"{readStateIndex:5150; appliedIndex:5149; }","duration":"578.316282ms","start":"2026-04-07T00:17:21.988479Z","end":"2026-04-07T00:17:22.566795Z","steps":["trace[2061222148] 'read index received' (duration: 41.661µs)","trace[2061222148] 'applied index is now lower than readState.Index' (duration: 578.227229ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:17:22.566855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:17:21.950537Z","time spent":"616.228618ms","remote":"127.0.0.1:52970","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7439,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:17:22.566725Z","caller":"traceutil/trace.go:171","msg":"trace[1286407481] transaction","detail":"{read_only:false; response_revision:4965; number_of_response:1; }","duration":"458.395794ms","start":"2026-04-07T00:17:22.108315Z","end":"2026-04-07T00:17:22.566711Z","steps":["trace[1286407481] 'process raft request' (duration: 458.300552ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:17:22.567043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.561118ms","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-04-07T00:17:22.567097Z","caller":"traceutil/trace.go:171","msg":"trace[729490076] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4965; }","duration":"578.6527ms","start":"2026-04-07T00:17:21.988421Z","end":"2026-04-07T00:17:22.567074Z","steps":["trace[729490076] 'agreement among raft nodes before linearized reading' (duration: 578.466215ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:17:22.567147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:17:21.988401Z","time spent":"578.737943ms","remote":"127.0.0.1:48150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12235,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-07T00:17:22.56751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.488909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T00:17:22.568147Z","caller":"traceutil/trace.go:171","msg":"trace[1758291479] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4965; }","duration":"410.160187ms","start":"2026-04-07T00:17:22.157972Z","end":"2026-04-07T00:17:22.568132Z","steps":["trace[1758291479] 'agreement among raft nodes before linearized reading' (duration: 409.510209ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:17:22.568222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:17:22.157951Z","time spent":"410.257839ms","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":29,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-04-07T00:17:22.567972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:17:22.108291Z","time spent":"458.691563ms","remote":"127.0.0.1:48210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":473,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:17:22.568327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.994908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-07T00:17:22.569123Z","caller":"traceutil/trace.go:171","msg":"trace[526230178] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4965; }","duration":"165.910723ms","start":"2026-04-07T00:17:22.40316Z","end":"2026-04-07T00:17:22.56907Z","steps":["trace[526230178] 'agreement among raft nodes before linearized reading' (duration: 164.35862ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:18:40.516584Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2920} {"level":"info","ts":"2026-04-07T00:18:40.587979Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2920,"took":"70.056203ms","hash":3673620525,"current-db-size-bytes":54534144,"current-db-size":"54 MB","current-db-size-in-use-bytes":29646848,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-07T00:18:40.588458Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3673620525,"revision":2920,"compact-revision":-1} {"level":"info","ts":"2026-04-07T00:23:40.521946Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5587} {"level":"info","ts":"2026-04-07T00:23:40.589718Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5587,"took":"66.454253ms","hash":749633603,"current-db-size-bytes":54534144,"current-db-size":"54 MB","current-db-size-in-use-bytes":18456576,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-07T00:23:40.589789Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":749633603,"revision":5587,"compact-revision":2920}