{"level":"warn","ts":"2026-04-08T06:18:43.244617Z","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-08T06:18:43.244726Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.115:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.115:2380","--initial-cluster=instance=https://199.204.45.115:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.115:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.115:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-08T06:18:43.244815Z","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-08T06:18:43.244884Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-04-08T06:18:43.244904Z","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-08T06:18:43.245554Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"]} {"level":"info","ts":"2026-04-08T06:18:43.245634Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.115:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-08T06:18:43.249429Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.559545ms"} {"level":"info","ts":"2026-04-08T06:18:43.258278Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e3aaa5c123e150e0","cluster-id":"61ec519698823541"} {"level":"info","ts":"2026-04-08T06:18:43.258418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T06:18:43.258454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 0"} {"level":"info","ts":"2026-04-08T06:18:43.258471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e3aaa5c123e150e0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T06:18:43.258499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 1"} {"level":"info","ts":"2026-04-08T06:18:43.258558Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"warn","ts":"2026-04-08T06:18:43.26267Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T06:18:43.265828Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T06:18:43.267048Z","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-08T06:18:43.269562Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e3aaa5c123e150e0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T06:18:43.269752Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e3aaa5c123e150e0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T06:18:43.269996Z","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-08T06:18:43.270186Z","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-08T06:18:43.270237Z","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-08T06:18:43.270654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"info","ts":"2026-04-08T06:18:43.270816Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","added-peer-id":"e3aaa5c123e150e0","added-peer-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-04-08T06:18:43.272342Z","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-08T06:18:43.272497Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-04-08T06:18:43.272624Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e3aaa5c123e150e0","initial-advertise-peer-urls":["https://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T06:18:43.272663Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T06:18:43.272637Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-04-08T06:18:43.559219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T06:18:43.559324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T06:18:43.559381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgPreVoteResp from e3aaa5c123e150e0 at term 1"} {"level":"info","ts":"2026-04-08T06:18:43.559406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became candidate at term 2"} {"level":"info","ts":"2026-04-08T06:18:43.559419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgVoteResp from e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-04-08T06:18:43.559435Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became leader at term 2"} {"level":"info","ts":"2026-04-08T06:18:43.559464Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e3aaa5c123e150e0 elected leader e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-04-08T06:18:43.560479Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e3aaa5c123e150e0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.115:2379]}","request-path":"/0/members/e3aaa5c123e150e0/attributes","cluster-id":"61ec519698823541","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T06:18:43.560474Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:18:43.560585Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T06:18:43.560628Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T06:18:43.560884Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T06:18:43.560985Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T06:18:43.561399Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:18:43.561534Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:18:43.561575Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:18:43.563528Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.115:2379"} {"level":"info","ts":"2026-04-08T06:18:43.564912Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T06:19:05.345169Z","caller":"traceutil/trace.go:171","msg":"trace[2026751661] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"108.222881ms","start":"2026-04-08T06:19:05.236918Z","end":"2026-04-08T06:19:05.345141Z","steps":["trace[2026751661] 'process raft request' (duration: 108.036436ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:19:05.365737Z","caller":"traceutil/trace.go:171","msg":"trace[1849921006] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"128.104744ms","start":"2026-04-08T06:19:05.237602Z","end":"2026-04-08T06:19:05.365707Z","steps":["trace[1849921006] 'process raft request' (duration: 127.93711ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:19:21.28134Z","caller":"traceutil/trace.go:171","msg":"trace[705346888] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"101.983335ms","start":"2026-04-08T06:19:21.179324Z","end":"2026-04-08T06:19:21.281307Z","steps":["trace[705346888] 'process raft request' (duration: 101.387161ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:19:21.506003Z","caller":"traceutil/trace.go:171","msg":"trace[251711654] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"162.588956ms","start":"2026-04-08T06:19:21.343381Z","end":"2026-04-08T06:19:21.50597Z","steps":["trace[251711654] 'process raft request' (duration: 162.301569ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:19:21.987029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.865191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rb5r6\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-08T06:19:21.987208Z","caller":"traceutil/trace.go:171","msg":"trace[422393884] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rb5r6; range_end:; response_count:1; response_revision:595; }","duration":"313.113897ms","start":"2026-04-08T06:19:21.674072Z","end":"2026-04-08T06:19:21.987186Z","steps":["trace[422393884] 'range keys from in-memory index tree' (duration: 312.690377ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:19:21.987275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:19:21.674049Z","time spent":"313.21451ms","remote":"127.0.0.1:44840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-rb5r6\" "} {"level":"warn","ts":"2026-04-08T06:19:21.987391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.004953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-08T06:19:21.987559Z","caller":"traceutil/trace.go:171","msg":"trace[197123291] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:595; }","duration":"385.269599ms","start":"2026-04-08T06:19:21.602258Z","end":"2026-04-08T06:19:21.987528Z","steps":["trace[197123291] 'range keys from in-memory index tree' (duration: 384.708756ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:19:21.987643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:19:21.602226Z","time spent":"385.404042ms","remote":"127.0.0.1:44946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-08T06:20:35.791751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.730437ms","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-08T06:20:35.792128Z","caller":"traceutil/trace.go:171","msg":"trace[1575230590] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1428; }","duration":"120.172597ms","start":"2026-04-08T06:20:35.671929Z","end":"2026-04-08T06:20:35.792102Z","steps":["trace[1575230590] 'range keys from in-memory index tree' (duration: 119.078522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:21:00.605951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.683501ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T06:21:00.606081Z","caller":"traceutil/trace.go:171","msg":"trace[1877490689] linearizableReadLoop","detail":"{readStateIndex:1912; appliedIndex:1911; }","duration":"310.652869ms","start":"2026-04-08T06:21:00.295411Z","end":"2026-04-08T06:21:00.606064Z","steps":["trace[1877490689] 'read index received' (duration: 74.851µs)","trace[1877490689] 'applied index is now lower than readState.Index' (duration: 310.576758ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:21:00.606103Z","caller":"traceutil/trace.go:171","msg":"trace[2031406408] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"356.673349ms","start":"2026-04-08T06:21:00.249394Z","end":"2026-04-08T06:21:00.606068Z","steps":["trace[2031406408] 'process raft request' (duration: 31.23492ms)","trace[2031406408] 'compare' (duration: 324.572479ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:21:00.606205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:21:00.249367Z","time spent":"356.789112ms","remote":"127.0.0.1:44946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T06:21:00.606261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.853914ms","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-08T06:21:00.606292Z","caller":"traceutil/trace.go:171","msg":"trace[380269166] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1843; }","duration":"310.922226ms","start":"2026-04-08T06:21:00.295359Z","end":"2026-04-08T06:21:00.606281Z","steps":["trace[380269166] 'agreement among raft nodes before linearized reading' (duration: 310.790103ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:21:00.606321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:21:00.295336Z","time spent":"310.978527ms","remote":"127.0.0.1:53276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-04-08T06:21:01.067146Z","caller":"traceutil/trace.go:171","msg":"trace[953086263] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"302.162878ms","start":"2026-04-08T06:21:00.764948Z","end":"2026-04-08T06:21:01.067111Z","steps":["trace[953086263] 'process raft request' (duration: 212.34846ms)","trace[953086263] 'compare' (duration: 89.459549ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:21:01.067363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:21:00.764903Z","time spent":"302.377183ms","remote":"127.0.0.1:44946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T06:21:01.067145Z","caller":"traceutil/trace.go:171","msg":"trace[1100449253] linearizableReadLoop","detail":"{readStateIndex:1915; appliedIndex:1914; }","duration":"291.363883ms","start":"2026-04-08T06:21:00.775735Z","end":"2026-04-08T06:21:01.067098Z","steps":["trace[1100449253] 'read index received' (duration: 201.530014ms)","trace[1100449253] 'applied index is now lower than readState.Index' (duration: 89.831429ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:21:01.067415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.65669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-98d2e81f-fa88-4296-96c9-e2c24cc61fd0\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-08T06:21:01.06749Z","caller":"traceutil/trace.go:171","msg":"trace[1566414501] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-98d2e81f-fa88-4296-96c9-e2c24cc61fd0; range_end:; response_count:1; response_revision:1846; }","duration":"291.780623ms","start":"2026-04-08T06:21:00.775691Z","end":"2026-04-08T06:21:01.067471Z","steps":["trace[1566414501] 'agreement among raft nodes before linearized reading' (duration: 291.542627ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:21:13.564219Z","caller":"traceutil/trace.go:171","msg":"trace[540526825] transaction","detail":"{read_only:false; response_revision:1955; number_of_response:1; }","duration":"209.563405ms","start":"2026-04-08T06:21:13.354621Z","end":"2026-04-08T06:21:13.564184Z","steps":["trace[540526825] 'process raft request' (duration: 209.149274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:21:51.134127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.600942ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T06:21:51.134241Z","caller":"traceutil/trace.go:171","msg":"trace[1270691093] linearizableReadLoop","detail":"{readStateIndex:2252; appliedIndex:2251; }","duration":"179.443302ms","start":"2026-04-08T06:21:50.954781Z","end":"2026-04-08T06:21:51.134224Z","steps":["trace[1270691093] 'read index received' (duration: 63.557623ms)","trace[1270691093] 'applied index is now lower than readState.Index' (duration: 115.884399ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:21:51.134433Z","caller":"traceutil/trace.go:171","msg":"trace[1845385042] transaction","detail":"{read_only:false; response_revision:2172; number_of_response:1; }","duration":"188.054107ms","start":"2026-04-08T06:21:50.94631Z","end":"2026-04-08T06:21:51.134365Z","steps":["trace[1845385042] 'process raft request' (duration: 72.133198ms)","trace[1845385042] 'compare' (duration: 115.478999ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:21:51.134551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.489463ms","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-08T06:21:51.134675Z","caller":"traceutil/trace.go:171","msg":"trace[700043030] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2172; }","duration":"142.662917ms","start":"2026-04-08T06:21:50.991991Z","end":"2026-04-08T06:21:51.134654Z","steps":["trace[700043030] 'agreement among raft nodes before linearized reading' (duration: 142.388641ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:21:51.134649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.849822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-08T06:21:51.134774Z","caller":"traceutil/trace.go:171","msg":"trace[340252890] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2172; }","duration":"180.049096ms","start":"2026-04-08T06:21:50.954699Z","end":"2026-04-08T06:21:51.134748Z","steps":["trace[340252890] 'agreement among raft nodes before linearized reading' (duration: 179.728259ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:21:51.832517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.867678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:21:51.832693Z","caller":"traceutil/trace.go:171","msg":"trace[1104494022] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"127.560386ms","start":"2026-04-08T06:21:51.70511Z","end":"2026-04-08T06:21:51.832671Z","steps":["trace[1104494022] 'process raft request' (duration: 37.808479ms)","trace[1104494022] 'compare' (duration: 89.631724ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:21:51.832652Z","caller":"traceutil/trace.go:171","msg":"trace[1217511667] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2174; }","duration":"318.108713ms","start":"2026-04-08T06:21:51.514523Z","end":"2026-04-08T06:21:51.832632Z","steps":["trace[1217511667] 'range keys from in-memory index tree' (duration: 317.774935ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:21:51.832507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.360583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T06:21:51.832894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:21:51.514501Z","time spent":"318.350838ms","remote":"127.0.0.1:44692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-08T06:21:51.832923Z","caller":"traceutil/trace.go:171","msg":"trace[1555329213] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:2174; }","duration":"214.814814ms","start":"2026-04-08T06:21:51.618057Z","end":"2026-04-08T06:21:51.832872Z","steps":["trace[1555329213] 'count revisions from in-memory index tree' (duration: 214.21313ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:22:39.306948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.62016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T06:22:39.307282Z","caller":"traceutil/trace.go:171","msg":"trace[355290378] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:2607; }","duration":"171.02374ms","start":"2026-04-08T06:22:39.136221Z","end":"2026-04-08T06:22:39.307244Z","steps":["trace[355290378] 'count revisions from in-memory index tree' (duration: 170.457637ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:23:13.671011Z","caller":"traceutil/trace.go:171","msg":"trace[395058914] transaction","detail":"{read_only:false; response_revision:2814; number_of_response:1; }","duration":"101.904817ms","start":"2026-04-08T06:23:13.569071Z","end":"2026-04-08T06:23:13.670976Z","steps":["trace[395058914] 'process raft request' (duration: 101.456257ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:23:13.827595Z","caller":"traceutil/trace.go:171","msg":"trace[1472607672] transaction","detail":"{read_only:false; response_revision:2815; number_of_response:1; }","duration":"257.657291ms","start":"2026-04-08T06:23:13.569903Z","end":"2026-04-08T06:23:13.827561Z","steps":["trace[1472607672] 'process raft request' (duration: 215.223897ms)","trace[1472607672] 'compare' (duration: 42.307101ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:27:22.983179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.183962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"info","ts":"2026-04-08T06:27:22.983267Z","caller":"traceutil/trace.go:171","msg":"trace[1535172266] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:5068; }","duration":"160.332095ms","start":"2026-04-08T06:27:22.822916Z","end":"2026-04-08T06:27:22.983248Z","steps":["trace[1535172266] 'range keys from in-memory index tree' (duration: 160.016768ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:27:22.98328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.768492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-04-08T06:27:22.983364Z","caller":"traceutil/trace.go:171","msg":"trace[1429034376] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5068; }","duration":"104.899706ms","start":"2026-04-08T06:27:22.878434Z","end":"2026-04-08T06:27:22.983334Z","steps":["trace[1429034376] 'range keys from in-memory index tree' (duration: 104.601458ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:27:22.983567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.193823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:777497"} {"level":"info","ts":"2026-04-08T06:27:22.983638Z","caller":"traceutil/trace.go:171","msg":"trace[775773945] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5068; }","duration":"135.318315ms","start":"2026-04-08T06:27:22.848302Z","end":"2026-04-08T06:27:22.98362Z","steps":["trace[775773945] 'range keys from in-memory index tree' (duration: 134.647069ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:27:23.108584Z","caller":"traceutil/trace.go:171","msg":"trace[2069378398] transaction","detail":"{read_only:false; response_revision:5069; number_of_response:1; }","duration":"121.072364ms","start":"2026-04-08T06:27:22.987484Z","end":"2026-04-08T06:27:23.108557Z","steps":["trace[2069378398] 'process raft request' (duration: 120.88648ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:27:23.169441Z","caller":"traceutil/trace.go:171","msg":"trace[525699412] linearizableReadLoop","detail":"{readStateIndex:5261; appliedIndex:5259; }","duration":"168.950212ms","start":"2026-04-08T06:27:23.000459Z","end":"2026-04-08T06:27:23.16941Z","steps":["trace[525699412] 'read index received' (duration: 107.95383ms)","trace[525699412] 'applied index is now lower than readState.Index' (duration: 60.994992ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:27:23.169844Z","caller":"traceutil/trace.go:171","msg":"trace[1923697850] transaction","detail":"{read_only:false; response_revision:5070; number_of_response:1; }","duration":"182.027296ms","start":"2026-04-08T06:27:22.987803Z","end":"2026-04-08T06:27:23.16983Z","steps":["trace[1923697850] 'process raft request' (duration: 181.370859ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:27:23.17027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.780372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2e7bc117-fe08-4136-a372-5c0ea14dbfa4\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-04-08T06:27:23.170312Z","caller":"traceutil/trace.go:171","msg":"trace[1646342689] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2e7bc117-fe08-4136-a372-5c0ea14dbfa4; range_end:; response_count:1; response_revision:5071; }","duration":"169.847954ms","start":"2026-04-08T06:27:23.000449Z","end":"2026-04-08T06:27:23.170297Z","steps":["trace[1646342689] 'agreement among raft nodes before linearized reading' (duration: 169.663349ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:27:34.78756Z","caller":"traceutil/trace.go:171","msg":"trace[309442943] transaction","detail":"{read_only:false; response_revision:5284; number_of_response:1; }","duration":"157.171339ms","start":"2026-04-08T06:27:34.630364Z","end":"2026-04-08T06:27:34.787535Z","steps":["trace[309442943] 'process raft request' (duration: 156.932033ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:27:35.352346Z","caller":"traceutil/trace.go:171","msg":"trace[1743816067] linearizableReadLoop","detail":"{readStateIndex:5487; appliedIndex:5486; }","duration":"190.364966ms","start":"2026-04-08T06:27:35.161957Z","end":"2026-04-08T06:27:35.352322Z","steps":["trace[1743816067] 'read index received' (duration: 190.233703ms)","trace[1743816067] 'applied index is now lower than readState.Index' (duration: 129.883µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:27:35.352476Z","caller":"traceutil/trace.go:171","msg":"trace[240858010] transaction","detail":"{read_only:false; response_revision:5290; number_of_response:1; }","duration":"268.758326ms","start":"2026-04-08T06:27:35.083673Z","end":"2026-04-08T06:27:35.352432Z","steps":["trace[240858010] 'process raft request' (duration: 268.489309ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:27:35.352641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.674453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-08T06:27:35.352705Z","caller":"traceutil/trace.go:171","msg":"trace[2006675995] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5290; }","duration":"190.849288ms","start":"2026-04-08T06:27:35.161843Z","end":"2026-04-08T06:27:35.352692Z","steps":["trace[2006675995] 'agreement among raft nodes before linearized reading' (duration: 190.617852ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:27:35.393918Z","caller":"traceutil/trace.go:171","msg":"trace[212971488] transaction","detail":"{read_only:false; response_revision:5291; number_of_response:1; }","duration":"186.993385ms","start":"2026-04-08T06:27:35.206892Z","end":"2026-04-08T06:27:35.393885Z","steps":["trace[212971488] 'process raft request' (duration: 186.740199ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:27:35.394109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.127721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-2f697.18a44dbdd37f4ef0\" ","response":"range_response_count:1 size:832"} {"level":"info","ts":"2026-04-08T06:27:35.394217Z","caller":"traceutil/trace.go:171","msg":"trace[352298870] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-2f697.18a44dbdd37f4ef0; range_end:; response_count:1; response_revision:5291; }","duration":"135.292254ms","start":"2026-04-08T06:27:35.258899Z","end":"2026-04-08T06:27:35.394191Z","steps":["trace[352298870] 'agreement among raft nodes before linearized reading' (duration: 134.989047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:27:35.394335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.218891ms","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-08T06:27:35.395007Z","caller":"traceutil/trace.go:171","msg":"trace[434010992] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5291; }","duration":"157.570239ms","start":"2026-04-08T06:27:35.236839Z","end":"2026-04-08T06:27:35.394409Z","steps":["trace[434010992] 'agreement among raft nodes before linearized reading' (duration: 157.059757ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:27:42.936053Z","caller":"traceutil/trace.go:171","msg":"trace[410301136] transaction","detail":"{read_only:false; response_revision:5464; number_of_response:1; }","duration":"110.668353ms","start":"2026-04-08T06:27:42.825358Z","end":"2026-04-08T06:27:42.936026Z","steps":["trace[410301136] 'process raft request' (duration: 110.366046ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:28:43.619857Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2979} {"level":"info","ts":"2026-04-08T06:28:43.695481Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2979,"took":"74.011206ms","hash":2603124093,"current-db-size-bytes":58052608,"current-db-size":"58 MB","current-db-size-in-use-bytes":33308672,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-08T06:28:43.695567Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2603124093,"revision":2979,"compact-revision":-1} {"level":"info","ts":"2026-04-08T06:33:41.692199Z","caller":"traceutil/trace.go:171","msg":"trace[2000876967] transaction","detail":"{read_only:false; response_revision:8114; number_of_response:1; }","duration":"144.814191ms","start":"2026-04-08T06:33:41.547351Z","end":"2026-04-08T06:33:41.692165Z","steps":["trace[2000876967] 'process raft request' (duration: 59.128465ms)","trace[2000876967] 'compare' (duration: 85.538042ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:33:41.893022Z","caller":"traceutil/trace.go:171","msg":"trace[1455888179] transaction","detail":"{read_only:false; response_revision:8115; number_of_response:1; }","duration":"130.73128ms","start":"2026-04-08T06:33:41.762245Z","end":"2026-04-08T06:33:41.892977Z","steps":["trace[1455888179] 'process raft request' (duration: 37.564985ms)","trace[1455888179] 'compare' (duration: 93.000641ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:33:43.627049Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6034} {"level":"info","ts":"2026-04-08T06:33:43.735633Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6034,"took":"106.055567ms","hash":2877814068,"current-db-size-bytes":58052608,"current-db-size":"58 MB","current-db-size-in-use-bytes":21700608,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-08T06:33:43.735723Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2877814068,"revision":6034,"compact-revision":2979} {"level":"info","ts":"2026-04-08T06:33:50.052763Z","caller":"traceutil/trace.go:171","msg":"trace[399258732] transaction","detail":"{read_only:false; response_revision:8295; number_of_response:1; }","duration":"131.329335ms","start":"2026-04-08T06:33:49.921407Z","end":"2026-04-08T06:33:50.052736Z","steps":["trace[399258732] 'process raft request' (duration: 131.137811ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:34:01.738279Z","caller":"traceutil/trace.go:171","msg":"trace[975066876] linearizableReadLoop","detail":"{readStateIndex:8651; appliedIndex:8649; }","duration":"121.615452ms","start":"2026-04-08T06:34:01.616636Z","end":"2026-04-08T06:34:01.738251Z","steps":["trace[975066876] 'read index received' (duration: 47.956066ms)","trace[975066876] 'applied index is now lower than readState.Index' (duration: 73.658156ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:34:01.73849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.815106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:34:01.738538Z","caller":"traceutil/trace.go:171","msg":"trace[91029872] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:8356; }","duration":"121.927309ms","start":"2026-04-08T06:34:01.616595Z","end":"2026-04-08T06:34:01.738523Z","steps":["trace[91029872] 'agreement among raft nodes before linearized reading' (duration: 121.773436ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:34:01.73872Z","caller":"traceutil/trace.go:171","msg":"trace[678256777] transaction","detail":"{read_only:false; response_revision:8356; number_of_response:1; }","duration":"155.070418ms","start":"2026-04-08T06:34:01.583613Z","end":"2026-04-08T06:34:01.738683Z","steps":["trace[678256777] 'process raft request' (duration: 154.547865ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:34:02.940191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.315373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5hmsn\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-08T06:34:02.940328Z","caller":"traceutil/trace.go:171","msg":"trace[930776806] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5hmsn; range_end:; response_count:1; response_revision:8361; }","duration":"194.512449ms","start":"2026-04-08T06:34:02.745784Z","end":"2026-04-08T06:34:02.940297Z","steps":["trace[930776806] 'range keys from in-memory index tree' (duration: 193.979855ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:34:03.569197Z","caller":"traceutil/trace.go:171","msg":"trace[1614562832] transaction","detail":"{read_only:false; response_revision:8364; number_of_response:1; }","duration":"160.218571ms","start":"2026-04-08T06:34:03.40892Z","end":"2026-04-08T06:34:03.569138Z","steps":["trace[1614562832] 'process raft request' (duration: 159.471934ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:34:03.874397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.014135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-08T06:34:03.87454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.591408ms","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-08T06:34:03.874621Z","caller":"traceutil/trace.go:171","msg":"trace[867097877] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8364; }","duration":"130.733331ms","start":"2026-04-08T06:34:03.743872Z","end":"2026-04-08T06:34:03.874605Z","steps":["trace[867097877] 'range keys from in-memory index tree' (duration: 130.30057ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:34:03.87454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.348259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-08T06:34:03.874742Z","caller":"traceutil/trace.go:171","msg":"trace[958899607] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8364; }","duration":"205.623846ms","start":"2026-04-08T06:34:03.669104Z","end":"2026-04-08T06:34:03.874728Z","steps":["trace[958899607] 'range keys from in-memory index tree' (duration: 205.056912ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:34:03.874512Z","caller":"traceutil/trace.go:171","msg":"trace[1843444720] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:8364; }","duration":"162.22404ms","start":"2026-04-08T06:34:03.712267Z","end":"2026-04-08T06:34:03.874491Z","steps":["trace[1843444720] 'count revisions from in-memory index tree' (duration: 161.847531ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:34:04.64255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.618602ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T06:34:04.642868Z","caller":"traceutil/trace.go:171","msg":"trace[1368605318] linearizableReadLoop","detail":"{readStateIndex:8668; appliedIndex:8666; }","duration":"130.014903ms","start":"2026-04-08T06:34:04.512828Z","end":"2026-04-08T06:34:04.642842Z","steps":["trace[1368605318] 'read index received' (duration: 3.036123ms)","trace[1368605318] 'applied index is now lower than readState.Index' (duration: 126.97739ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:34:04.643029Z","caller":"traceutil/trace.go:171","msg":"trace[148065565] transaction","detail":"{read_only:false; response_revision:8372; number_of_response:1; }","duration":"189.879936ms","start":"2026-04-08T06:34:04.453136Z","end":"2026-04-08T06:34:04.643016Z","steps":["trace[148065565] 'process raft request' (duration: 189.63615ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:34:04.643293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.439344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:34:04.643305Z","caller":"traceutil/trace.go:171","msg":"trace[1076174210] transaction","detail":"{read_only:false; response_revision:8371; number_of_response:1; }","duration":"195.149254ms","start":"2026-04-08T06:34:04.448125Z","end":"2026-04-08T06:34:04.643275Z","steps":["trace[1076174210] 'process raft request' (duration: 67.665461ms)","trace[1076174210] 'compare' (duration: 126.459078ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:34:04.643393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.505117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-08T06:34:04.643434Z","caller":"traceutil/trace.go:171","msg":"trace[1608976156] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8372; }","duration":"130.636419ms","start":"2026-04-08T06:34:04.512758Z","end":"2026-04-08T06:34:04.643394Z","steps":["trace[1608976156] 'agreement among raft nodes before linearized reading' (duration: 130.407583ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:34:04.643504Z","caller":"traceutil/trace.go:171","msg":"trace[1448794457] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8372; }","duration":"106.758034ms","start":"2026-04-08T06:34:04.536724Z","end":"2026-04-08T06:34:04.643482Z","steps":["trace[1448794457] 'agreement among raft nodes before linearized reading' (duration: 106.421115ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:34:32.618187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.878158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:34:32.618289Z","caller":"traceutil/trace.go:171","msg":"trace[428944053] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8573; }","duration":"104.988931ms","start":"2026-04-08T06:34:32.513275Z","end":"2026-04-08T06:34:32.618264Z","steps":["trace[428944053] 'range keys from in-memory index tree' (duration: 104.764886ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:34:32.618494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.098266ms","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-08T06:34:32.618603Z","caller":"traceutil/trace.go:171","msg":"trace[445449338] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8573; }","duration":"164.27459ms","start":"2026-04-08T06:34:32.454305Z","end":"2026-04-08T06:34:32.61858Z","steps":["trace[445449338] 'range keys from in-memory index tree' (duration: 163.85567ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:34:32.767804Z","caller":"traceutil/trace.go:171","msg":"trace[1943668074] transaction","detail":"{read_only:false; response_revision:8574; number_of_response:1; }","duration":"142.781332ms","start":"2026-04-08T06:34:32.624979Z","end":"2026-04-08T06:34:32.76776Z","steps":["trace[1943668074] 'process raft request' (duration: 142.526555ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:34:32.793162Z","caller":"traceutil/trace.go:171","msg":"trace[1111471587] transaction","detail":"{read_only:false; response_revision:8575; number_of_response:1; }","duration":"166.148184ms","start":"2026-04-08T06:34:32.626977Z","end":"2026-04-08T06:34:32.793126Z","steps":["trace[1111471587] 'process raft request' (duration: 165.951319ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:34:35.776129Z","caller":"traceutil/trace.go:171","msg":"trace[1361244109] transaction","detail":"{read_only:false; response_revision:8591; number_of_response:1; }","duration":"256.39758ms","start":"2026-04-08T06:34:35.519699Z","end":"2026-04-08T06:34:35.776096Z","steps":["trace[1361244109] 'process raft request' (duration: 256.183965ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:35:21.192497Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002488.wal"} {"level":"info","ts":"2026-04-08T06:36:34.73706Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e3aaa5c123e150e0","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-08T06:36:34.743065Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-08T06:36:34.743222Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-08T06:38:43.633711Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8132} {"level":"info","ts":"2026-04-08T06:38:43.701752Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8132,"took":"65.031957ms","hash":2155890114,"current-db-size-bytes":58052608,"current-db-size":"58 MB","current-db-size-in-use-bytes":28098560,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-04-08T06:38:43.701847Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2155890114,"revision":8132,"compact-revision":6034} {"level":"info","ts":"2026-04-08T06:43:43.641064Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10488} {"level":"info","ts":"2026-04-08T06:43:43.72165Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10488,"took":"77.408128ms","hash":3428515796,"current-db-size-bytes":58052608,"current-db-size":"58 MB","current-db-size-in-use-bytes":21520384,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-08T06:43:43.721726Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3428515796,"revision":10488,"compact-revision":8132}