{"level":"warn","ts":"2026-04-23T09:45:57.816133Z","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-23T09:45:57.816245Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.238: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.238:2380","--initial-cluster=instance=https://199.19.213.238:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.238:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.238: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-23T09:45:57.816328Z","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-23T09:45:57.816345Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.238:2380"]} {"level":"info","ts":"2026-04-23T09:45:57.816367Z","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-23T09:45:57.817221Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.238:2379"]} {"level":"info","ts":"2026-04-23T09:45:57.817325Z","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.238:2380"],"listen-peer-urls":["https://199.19.213.238:2380"],"advertise-client-urls":["https://199.19.213.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.238: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-23T09:45:57.822054Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.451644ms"} {"level":"info","ts":"2026-04-23T09:45:57.830005Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8cf6035374726417","cluster-id":"e837e6e114b087e2"} {"level":"info","ts":"2026-04-23T09:45:57.830096Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 switched to configuration voters=()"} {"level":"info","ts":"2026-04-23T09:45:57.830125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 became follower at term 0"} {"level":"info","ts":"2026-04-23T09:45:57.830144Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8cf6035374726417 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-23T09:45:57.830175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 became follower at term 1"} {"level":"info","ts":"2026-04-23T09:45:57.830227Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 switched to configuration voters=(10157309666551555095)"} {"level":"warn","ts":"2026-04-23T09:45:57.837309Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-23T09:45:57.839541Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-23T09:45:57.842558Z","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-23T09:45:57.850482Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"8cf6035374726417","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-23T09:45:57.853547Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8cf6035374726417","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-23T09:45:57.853808Z","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-23T09:45:57.85386Z","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-23T09:45:57.853879Z","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-23T09:45:57.855889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 switched to configuration voters=(10157309666551555095)"} {"level":"info","ts":"2026-04-23T09:45:57.856059Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e837e6e114b087e2","local-member-id":"8cf6035374726417","added-peer-id":"8cf6035374726417","added-peer-peer-urls":["https://199.19.213.238:2380"]} {"level":"info","ts":"2026-04-23T09:45:57.862781Z","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-23T09:45:57.86303Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.238:2380"} {"level":"info","ts":"2026-04-23T09:45:57.863178Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.238:2380"} {"level":"info","ts":"2026-04-23T09:45:57.863185Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"8cf6035374726417","initial-advertise-peer-urls":["https://199.19.213.238:2380"],"listen-peer-urls":["https://199.19.213.238:2380"],"advertise-client-urls":["https://199.19.213.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-23T09:45:57.863254Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-23T09:45:58.130674Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 is starting a new election at term 1"} {"level":"info","ts":"2026-04-23T09:45:58.130735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-23T09:45:58.130757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 received MsgPreVoteResp from 8cf6035374726417 at term 1"} {"level":"info","ts":"2026-04-23T09:45:58.130776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 became candidate at term 2"} {"level":"info","ts":"2026-04-23T09:45:58.130788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 received MsgVoteResp from 8cf6035374726417 at term 2"} {"level":"info","ts":"2026-04-23T09:45:58.130803Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 became leader at term 2"} {"level":"info","ts":"2026-04-23T09:45:58.13082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8cf6035374726417 elected leader 8cf6035374726417 at term 2"} {"level":"info","ts":"2026-04-23T09:45:58.132367Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T09:45:58.133096Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"8cf6035374726417","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.238:2379]}","request-path":"/0/members/8cf6035374726417/attributes","cluster-id":"e837e6e114b087e2","publish-timeout":"7s"} {"level":"info","ts":"2026-04-23T09:45:58.133286Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T09:45:58.13333Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T09:45:58.133356Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-23T09:45:58.133546Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-23T09:45:58.136075Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e837e6e114b087e2","local-member-id":"8cf6035374726417","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T09:45:58.13621Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T09:45:58.136261Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T09:45:58.136482Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-23T09:45:58.137767Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.238:2379"} {"level":"info","ts":"2026-04-23T09:46:22.333834Z","caller":"traceutil/trace.go:171","msg":"trace[1219439959] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"137.53804ms","start":"2026-04-23T09:46:22.196279Z","end":"2026-04-23T09:46:22.333817Z","steps":["trace[1219439959] 'process raft request' (duration: 137.409908ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:46:22.339437Z","caller":"traceutil/trace.go:171","msg":"trace[552022634] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"137.925895ms","start":"2026-04-23T09:46:22.20149Z","end":"2026-04-23T09:46:22.339416Z","steps":["trace[552022634] 'process raft request' (duration: 137.278117ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:46:22.339567Z","caller":"traceutil/trace.go:171","msg":"trace[703197163] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"134.029775ms","start":"2026-04-23T09:46:22.205523Z","end":"2026-04-23T09:46:22.339552Z","steps":["trace[703197163] 'process raft request' (duration: 133.325627ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:46:22.339719Z","caller":"traceutil/trace.go:171","msg":"trace[1433407228] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"129.067141ms","start":"2026-04-23T09:46:22.21064Z","end":"2026-04-23T09:46:22.339707Z","steps":["trace[1433407228] 'process raft request' (duration: 128.237001ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:46:22.339823Z","caller":"traceutil/trace.go:171","msg":"trace[130646525] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"129.121112ms","start":"2026-04-23T09:46:22.210695Z","end":"2026-04-23T09:46:22.339816Z","steps":["trace[130646525] 'process raft request' (duration: 128.2082ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:46:22.339902Z","caller":"traceutil/trace.go:171","msg":"trace[513721632] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"127.253738ms","start":"2026-04-23T09:46:22.21264Z","end":"2026-04-23T09:46:22.339894Z","steps":["trace[513721632] 'process raft request' (duration: 126.291356ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:46:22.339977Z","caller":"traceutil/trace.go:171","msg":"trace[2053799296] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"124.619054ms","start":"2026-04-23T09:46:22.215352Z","end":"2026-04-23T09:46:22.339971Z","steps":["trace[2053799296] 'process raft request' (duration: 123.608232ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:46:22.34005Z","caller":"traceutil/trace.go:171","msg":"trace[277568113] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"117.985649ms","start":"2026-04-23T09:46:22.222059Z","end":"2026-04-23T09:46:22.340045Z","steps":["trace[277568113] 'process raft request' (duration: 116.928306ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:46:22.340125Z","caller":"traceutil/trace.go:171","msg":"trace[171829440] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"103.872259ms","start":"2026-04-23T09:46:22.236247Z","end":"2026-04-23T09:46:22.340119Z","steps":["trace[171829440] 'process raft request' (duration: 102.768796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:46:29.177991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.917817ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-23T09:46:29.17815Z","caller":"traceutil/trace.go:171","msg":"trace[2069027612] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:627; }","duration":"450.911016ms","start":"2026-04-23T09:46:28.72722Z","end":"2026-04-23T09:46:29.178131Z","steps":["trace[2069027612] 'read index received' (duration: 265.27145ms)","trace[2069027612] 'applied index is now lower than readState.Index' (duration: 185.638146ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:46:29.178265Z","caller":"traceutil/trace.go:171","msg":"trace[1483780384] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"465.778252ms","start":"2026-04-23T09:46:28.712456Z","end":"2026-04-23T09:46:29.178235Z","steps":["trace[1483780384] 'process raft request' (duration: 280.019585ms)","trace[1483780384] 'compare' (duration: 184.714564ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T09:46:29.178361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:46:28.712437Z","time spent":"465.872863ms","remote":"127.0.0.1:53422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T09:46:29.178467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.35814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-77xpd\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-23T09:46:29.17852Z","caller":"traceutil/trace.go:171","msg":"trace[1068902230] range","detail":"{range_begin:/registry/pods/kube-system/cilium-77xpd; range_end:; response_count:1; response_revision:606; }","duration":"196.481971ms","start":"2026-04-23T09:46:28.982025Z","end":"2026-04-23T09:46:29.178507Z","steps":["trace[1068902230] 'agreement among raft nodes before linearized reading' (duration: 196.295239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:46:29.178814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.553853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-23T09:46:29.178912Z","caller":"traceutil/trace.go:171","msg":"trace[344564550] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:606; }","duration":"451.703845ms","start":"2026-04-23T09:46:28.72719Z","end":"2026-04-23T09:46:29.178894Z","steps":["trace[344564550] 'agreement among raft nodes before linearized reading' (duration: 451.27245ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:46:29.178991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:46:28.72718Z","time spent":"451.765506ms","remote":"127.0.0.1:53208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-23T09:48:52.870106Z","caller":"traceutil/trace.go:171","msg":"trace[144489463] linearizableReadLoop","detail":"{readStateIndex:1762; appliedIndex:1761; }","duration":"194.621958ms","start":"2026-04-23T09:48:52.675453Z","end":"2026-04-23T09:48:52.870075Z","steps":["trace[144489463] 'read index received' (duration: 194.244258ms)","trace[144489463] 'applied index is now lower than readState.Index' (duration: 376.41µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:48:52.870275Z","caller":"traceutil/trace.go:171","msg":"trace[1052643441] transaction","detail":"{read_only:false; response_revision:1706; number_of_response:1; }","duration":"225.538365ms","start":"2026-04-23T09:48:52.64469Z","end":"2026-04-23T09:48:52.870228Z","steps":["trace[1052643441] 'process raft request' (duration: 225.189817ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:48:52.870349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.854913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:48:52.870603Z","caller":"traceutil/trace.go:171","msg":"trace[1847861470] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1706; }","duration":"195.16077ms","start":"2026-04-23T09:48:52.675387Z","end":"2026-04-23T09:48:52.870548Z","steps":["trace[1847861470] 'agreement among raft nodes before linearized reading' (duration: 194.878983ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:48:52.870882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.851696ms","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-23T09:48:52.870979Z","caller":"traceutil/trace.go:171","msg":"trace[331267936] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1706; }","duration":"119.975739ms","start":"2026-04-23T09:48:52.75098Z","end":"2026-04-23T09:48:52.870956Z","steps":["trace[331267936] 'agreement among raft nodes before linearized reading' (duration: 119.578499ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:48:52.87126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.006361ms","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-23T09:48:52.871332Z","caller":"traceutil/trace.go:171","msg":"trace[477928459] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1706; }","duration":"194.689778ms","start":"2026-04-23T09:48:52.676626Z","end":"2026-04-23T09:48:52.871316Z","steps":["trace[477928459] 'agreement among raft nodes before linearized reading' (duration: 193.719204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:49:15.952265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.858343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:10328"} {"level":"info","ts":"2026-04-23T09:49:15.952354Z","caller":"traceutil/trace.go:171","msg":"trace[1739944767] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2207; }","duration":"485.013946ms","start":"2026-04-23T09:49:15.46732Z","end":"2026-04-23T09:49:15.952334Z","steps":["trace[1739944767] 'range keys from in-memory index tree' (duration: 484.643298ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:49:15.952388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:49:15.46729Z","time spent":"485.090398ms","remote":"127.0.0.1:53120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":10352,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-04-23T09:49:15.961572Z","caller":"traceutil/trace.go:171","msg":"trace[2143908605] transaction","detail":"{read_only:false; response_revision:2208; number_of_response:1; }","duration":"489.441579ms","start":"2026-04-23T09:49:15.472114Z","end":"2026-04-23T09:49:15.961555Z","steps":["trace[2143908605] 'process raft request' (duration: 489.312706ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:49:15.961687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:49:15.472099Z","time spent":"489.524191ms","remote":"127.0.0.1:53012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":922,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T09:49:16.002742Z","caller":"traceutil/trace.go:171","msg":"trace[861214356] linearizableReadLoop","detail":"{readStateIndex:2298; appliedIndex:2296; }","duration":"413.42945ms","start":"2026-04-23T09:49:15.589267Z","end":"2026-04-23T09:49:16.002696Z","steps":["trace[861214356] 'read index received' (duration: 372.201232ms)","trace[861214356] 'applied index is now lower than readState.Index' (duration: 41.226608ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:49:16.002775Z","caller":"traceutil/trace.go:171","msg":"trace[2111203586] transaction","detail":"{read_only:false; response_revision:2209; number_of_response:1; }","duration":"442.112419ms","start":"2026-04-23T09:49:15.560618Z","end":"2026-04-23T09:49:16.002731Z","steps":["trace[2111203586] 'process raft request' (duration: 441.833252ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:49:16.002961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.351263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:49:16.003222Z","caller":"traceutil/trace.go:171","msg":"trace[1712861027] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2210; }","duration":"328.63448ms","start":"2026-04-23T09:49:15.67457Z","end":"2026-04-23T09:49:16.003204Z","steps":["trace[1712861027] 'agreement among raft nodes before linearized reading' (duration: 328.329242ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:49:16.003286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:49:15.674557Z","time spent":"328.719972ms","remote":"127.0.0.1:52932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-23T09:49:16.003479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.194158ms","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-23T09:49:16.00354Z","caller":"traceutil/trace.go:171","msg":"trace[2112136396] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2210; }","duration":"414.332751ms","start":"2026-04-23T09:49:15.589195Z","end":"2026-04-23T09:49:16.003528Z","steps":["trace[2112136396] 'agreement among raft nodes before linearized reading' (duration: 414.181157ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:49:16.003518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:49:15.560601Z","time spent":"442.409906ms","remote":"127.0.0.1:53208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T09:49:16.00358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:49:15.589166Z","time spent":"414.403863ms","remote":"127.0.0.1:53208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-23T09:49:16.002909Z","caller":"traceutil/trace.go:171","msg":"trace[945495841] transaction","detail":"{read_only:false; response_revision:2210; number_of_response:1; }","duration":"282.497157ms","start":"2026-04-23T09:49:15.720397Z","end":"2026-04-23T09:49:16.002894Z","steps":["trace[945495841] 'process raft request' (duration: 282.243182ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:49:16.003876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.913455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7bf4451f-289b-4ac4-85e5-db2bd0206761\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-23T09:49:16.003995Z","caller":"traceutil/trace.go:171","msg":"trace[90406912] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7bf4451f-289b-4ac4-85e5-db2bd0206761; range_end:; response_count:1; response_revision:2210; }","duration":"229.007678ms","start":"2026-04-23T09:49:15.774893Z","end":"2026-04-23T09:49:16.003901Z","steps":["trace[90406912] 'agreement among raft nodes before linearized reading' (duration: 228.830994ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:49:16.004034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.259237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7d76c874-92df-416c-ab97-1b340d9b320c\" ","response":"range_response_count:1 size:3617"} {"level":"info","ts":"2026-04-23T09:49:16.004172Z","caller":"traceutil/trace.go:171","msg":"trace[1103100676] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7d76c874-92df-416c-ab97-1b340d9b320c; range_end:; response_count:1; response_revision:2210; }","duration":"250.468142ms","start":"2026-04-23T09:49:15.753674Z","end":"2026-04-23T09:49:16.004142Z","steps":["trace[1103100676] 'agreement among raft nodes before linearized reading' (duration: 249.858838ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:49:46.473888Z","caller":"traceutil/trace.go:171","msg":"trace[581677364] transaction","detail":"{read_only:false; response_revision:2476; number_of_response:1; }","duration":"164.958986ms","start":"2026-04-23T09:49:46.308894Z","end":"2026-04-23T09:49:46.473853Z","steps":["trace[581677364] 'process raft request' (duration: 164.685269ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:49:47.564405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.01485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-23T09:49:47.564525Z","caller":"traceutil/trace.go:171","msg":"trace[1879804156] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:2479; }","duration":"224.176733ms","start":"2026-04-23T09:49:47.340317Z","end":"2026-04-23T09:49:47.564494Z","steps":["trace[1879804156] 'count revisions from in-memory index tree' (duration: 223.886278ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:49:47.564507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.582194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:49:47.564621Z","caller":"traceutil/trace.go:171","msg":"trace[971702905] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:2479; }","duration":"105.728677ms","start":"2026-04-23T09:49:47.458867Z","end":"2026-04-23T09:49:47.564596Z","steps":["trace[971702905] 'count revisions from in-memory index tree' (duration: 105.44918ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:49:47.564834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.689062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-23T09:49:47.564972Z","caller":"traceutil/trace.go:171","msg":"trace[2038378353] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2479; }","duration":"344.904888ms","start":"2026-04-23T09:49:47.220043Z","end":"2026-04-23T09:49:47.564948Z","steps":["trace[2038378353] 'range keys from in-memory index tree' (duration: 344.02772ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:49:47.565067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:49:47.220014Z","time spent":"345.026189ms","remote":"127.0.0.1:53208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-23T09:49:47.566054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.829555ms","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-23T09:49:47.566132Z","caller":"traceutil/trace.go:171","msg":"trace[1815694045] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2479; }","duration":"345.980789ms","start":"2026-04-23T09:49:47.220133Z","end":"2026-04-23T09:49:47.566114Z","steps":["trace[1815694045] 'range keys from in-memory index tree' (duration: 345.666212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:49:47.566174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:49:47.220099Z","time spent":"346.06291ms","remote":"127.0.0.1:53208","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":"info","ts":"2026-04-23T09:52:07.821398Z","caller":"traceutil/trace.go:171","msg":"trace[495054375] transaction","detail":"{read_only:false; response_revision:3302; number_of_response:1; }","duration":"113.281709ms","start":"2026-04-23T09:52:07.708082Z","end":"2026-04-23T09:52:07.821363Z","steps":["trace[495054375] 'process raft request' (duration: 101.911639ms)","trace[495054375] 'compare' (duration: 11.053506ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T09:52:13.457387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.542436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-04-23T09:52:13.457456Z","caller":"traceutil/trace.go:171","msg":"trace[455274150] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:3332; }","duration":"106.606327ms","start":"2026-04-23T09:52:13.350834Z","end":"2026-04-23T09:52:13.457441Z","steps":["trace[455274150] 'range keys from in-memory index tree' (duration: 106.404794ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:52:13.457364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.254369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-23T09:52:13.457636Z","caller":"traceutil/trace.go:171","msg":"trace[897703093] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:3332; }","duration":"208.579513ms","start":"2026-04-23T09:52:13.249028Z","end":"2026-04-23T09:52:13.457607Z","steps":["trace[897703093] 'count revisions from in-memory index tree' (duration: 208.172177ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:52:13.458403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.973516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-23T09:52:13.458463Z","caller":"traceutil/trace.go:171","msg":"trace[1954310229] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3332; }","duration":"202.061107ms","start":"2026-04-23T09:52:13.256392Z","end":"2026-04-23T09:52:13.458453Z","steps":["trace[1954310229] 'range keys from in-memory index tree' (duration: 201.889205ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:54:08.343993Z","caller":"traceutil/trace.go:171","msg":"trace[1655977894] transaction","detail":"{read_only:false; response_revision:4097; number_of_response:1; }","duration":"125.903309ms","start":"2026-04-23T09:54:08.218064Z","end":"2026-04-23T09:54:08.343968Z","steps":["trace[1655977894] 'process raft request' (duration: 125.725337ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:55:58.292852Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2886} {"level":"info","ts":"2026-04-23T09:55:58.378888Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2886,"took":"84.942756ms","hash":2609458185,"current-db-size-bytes":53809152,"current-db-size":"54 MB","current-db-size-in-use-bytes":29851648,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-23T09:55:58.378951Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2609458185,"revision":2886,"compact-revision":-1} {"level":"info","ts":"2026-04-23T09:55:59.860057Z","caller":"traceutil/trace.go:171","msg":"trace[1044231809] transaction","detail":"{read_only:false; response_revision:5557; number_of_response:1; }","duration":"100.51796ms","start":"2026-04-23T09:55:59.759514Z","end":"2026-04-23T09:55:59.860032Z","steps":["trace[1044231809] 'process raft request' (duration: 83.982833ms)","trace[1044231809] 'compare' (duration: 14.607663ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:56:01.021112Z","caller":"traceutil/trace.go:171","msg":"trace[1957803787] transaction","detail":"{read_only:false; response_revision:5593; number_of_response:1; }","duration":"133.14577ms","start":"2026-04-23T09:56:00.887929Z","end":"2026-04-23T09:56:01.021075Z","steps":["trace[1957803787] 'process raft request' (duration: 132.934647ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:56:06.44276Z","caller":"traceutil/trace.go:171","msg":"trace[1190111793] transaction","detail":"{read_only:false; response_revision:5682; number_of_response:1; }","duration":"224.564051ms","start":"2026-04-23T09:56:06.218179Z","end":"2026-04-23T09:56:06.442743Z","steps":["trace[1190111793] 'process raft request' (duration: 220.937716ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:56:06.442809Z","caller":"traceutil/trace.go:171","msg":"trace[563694933] transaction","detail":"{read_only:false; response_revision:5683; number_of_response:1; }","duration":"224.389889ms","start":"2026-04-23T09:56:06.218401Z","end":"2026-04-23T09:56:06.44279Z","steps":["trace[563694933] 'process raft request' (duration: 224.263707ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:56:06.442954Z","caller":"traceutil/trace.go:171","msg":"trace[1157970324] linearizableReadLoop","detail":"{readStateIndex:5895; appliedIndex:5892; }","duration":"142.167098ms","start":"2026-04-23T09:56:06.300758Z","end":"2026-04-23T09:56:06.442925Z","steps":["trace[1157970324] 'read index received' (duration: 138.354511ms)","trace[1157970324] 'applied index is now lower than readState.Index' (duration: 3.809947ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:56:06.442993Z","caller":"traceutil/trace.go:171","msg":"trace[1163364451] transaction","detail":"{read_only:false; response_revision:5684; number_of_response:1; }","duration":"224.54129ms","start":"2026-04-23T09:56:06.218439Z","end":"2026-04-23T09:56:06.442981Z","steps":["trace[1163364451] 'process raft request' (duration: 224.299437ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:56:06.44342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.646036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-23T09:56:06.443458Z","caller":"traceutil/trace.go:171","msg":"trace[1550469152] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5684; }","duration":"142.719626ms","start":"2026-04-23T09:56:06.300727Z","end":"2026-04-23T09:56:06.443447Z","steps":["trace[1550469152] 'agreement among raft nodes before linearized reading' (duration: 142.329621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:56:06.447361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.513464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:56:06.447444Z","caller":"traceutil/trace.go:171","msg":"trace[934176598] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:5685; }","duration":"106.659735ms","start":"2026-04-23T09:56:06.340765Z","end":"2026-04-23T09:56:06.447424Z","steps":["trace[934176598] 'agreement among raft nodes before linearized reading' (duration: 106.508073ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:56:24.791931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.45444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:56:24.792016Z","caller":"traceutil/trace.go:171","msg":"trace[877358266] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5863; }","duration":"116.582642ms","start":"2026-04-23T09:56:24.67541Z","end":"2026-04-23T09:56:24.791992Z","steps":["trace[877358266] 'range keys from in-memory index tree' (duration: 116.361549ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:58:41.43507Z","caller":"traceutil/trace.go:171","msg":"trace[2078781399] transaction","detail":"{read_only:false; response_revision:6829; number_of_response:1; }","duration":"123.610236ms","start":"2026-04-23T09:58:41.311434Z","end":"2026-04-23T09:58:41.435045Z","steps":["trace[2078781399] 'process raft request' (duration: 42.625492ms)","trace[2078781399] 'compare' (duration: 80.617174ms)"],"step_count":2}