{"level":"warn","ts":"2026-04-22T00:27:26.273246Z","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-22T00:27:26.273395Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.141: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.141:2380","--initial-cluster=instance=https://199.204.45.141:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.141:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.141: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-22T00:27:26.273488Z","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-22T00:27:26.273503Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.141:2380"]} {"level":"info","ts":"2026-04-22T00:27:26.273534Z","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-22T00:27:26.274524Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"]} {"level":"info","ts":"2026-04-22T00:27:26.274635Z","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.141:2380"],"listen-peer-urls":["https://199.204.45.141:2380"],"advertise-client-urls":["https://199.204.45.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.141: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-22T00:27:26.27851Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.567537ms"} {"level":"info","ts":"2026-04-22T00:27:26.285074Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9ef3b4f68930dc2","cluster-id":"b19a5957e6e65747"} {"level":"info","ts":"2026-04-22T00:27:26.285218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=()"} {"level":"info","ts":"2026-04-22T00:27:26.285262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became follower at term 0"} {"level":"info","ts":"2026-04-22T00:27:26.285281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9ef3b4f68930dc2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-22T00:27:26.285306Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became follower at term 1"} {"level":"info","ts":"2026-04-22T00:27:26.285363Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=(715856078018121154)"} {"level":"warn","ts":"2026-04-22T00:27:26.297236Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-22T00:27:26.29905Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-22T00:27:26.300363Z","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-22T00:27:26.303696Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9ef3b4f68930dc2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-22T00:27:26.305029Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9ef3b4f68930dc2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-22T00:27:26.305219Z","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-22T00:27:26.305287Z","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-22T00:27:26.305306Z","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-22T00:27:26.307344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=(715856078018121154)"} {"level":"info","ts":"2026-04-22T00:27:26.307642Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b19a5957e6e65747","local-member-id":"9ef3b4f68930dc2","added-peer-id":"9ef3b4f68930dc2","added-peer-peer-urls":["https://199.204.45.141:2380"]} {"level":"info","ts":"2026-04-22T00:27:26.310189Z","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-22T00:27:26.310525Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9ef3b4f68930dc2","initial-advertise-peer-urls":["https://199.204.45.141:2380"],"listen-peer-urls":["https://199.204.45.141:2380"],"advertise-client-urls":["https://199.204.45.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-22T00:27:26.310563Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-22T00:27:26.310611Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.141:2380"} {"level":"info","ts":"2026-04-22T00:27:26.310647Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.141:2380"} {"level":"info","ts":"2026-04-22T00:27:26.48662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 is starting a new election at term 1"} {"level":"info","ts":"2026-04-22T00:27:26.486758Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-22T00:27:26.486802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 received MsgPreVoteResp from 9ef3b4f68930dc2 at term 1"} {"level":"info","ts":"2026-04-22T00:27:26.486828Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became candidate at term 2"} {"level":"info","ts":"2026-04-22T00:27:26.486842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 received MsgVoteResp from 9ef3b4f68930dc2 at term 2"} {"level":"info","ts":"2026-04-22T00:27:26.48686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became leader at term 2"} {"level":"info","ts":"2026-04-22T00:27:26.486877Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9ef3b4f68930dc2 elected leader 9ef3b4f68930dc2 at term 2"} {"level":"info","ts":"2026-04-22T00:27:26.488401Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9ef3b4f68930dc2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.141:2379]}","request-path":"/0/members/9ef3b4f68930dc2/attributes","cluster-id":"b19a5957e6e65747","publish-timeout":"7s"} {"level":"info","ts":"2026-04-22T00:27:26.488471Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T00:27:26.488523Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T00:27:26.488785Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-22T00:27:26.488876Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-22T00:27:26.488994Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:27:26.490495Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b19a5957e6e65747","local-member-id":"9ef3b4f68930dc2","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:27:26.490801Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:27:26.490937Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:27:26.492869Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.141:2379"} {"level":"info","ts":"2026-04-22T00:27:26.493168Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-22T00:27:46.695303Z","caller":"traceutil/trace.go:171","msg":"trace[1167804766] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"131.777829ms","start":"2026-04-22T00:27:46.563485Z","end":"2026-04-22T00:27:46.695262Z","steps":["trace[1167804766] 'process raft request' (duration: 131.527654ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:04.453541Z","caller":"traceutil/trace.go:171","msg":"trace[1908056871] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"115.39019ms","start":"2026-04-22T00:28:04.338132Z","end":"2026-04-22T00:28:04.453522Z","steps":["trace[1908056871] 'process raft request' (duration: 115.272868ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:04.685954Z","caller":"traceutil/trace.go:171","msg":"trace[223978237] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"148.629146ms","start":"2026-04-22T00:28:04.537281Z","end":"2026-04-22T00:28:04.68591Z","steps":["trace[223978237] 'process raft request' (duration: 148.043733ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:04.884676Z","caller":"traceutil/trace.go:171","msg":"trace[2070516813] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"138.729116ms","start":"2026-04-22T00:28:04.745715Z","end":"2026-04-22T00:28:04.884444Z","steps":["trace[2070516813] 'process raft request' (duration: 138.537912ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:28:05.263719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.271182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T00:28:05.263781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.41116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:28:05.263836Z","caller":"traceutil/trace.go:171","msg":"trace[71761695] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:584; }","duration":"174.500447ms","start":"2026-04-22T00:28:05.089309Z","end":"2026-04-22T00:28:05.263809Z","steps":["trace[71761695] 'count revisions from in-memory index tree' (duration: 174.222832ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:05.263877Z","caller":"traceutil/trace.go:171","msg":"trace[224665496] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:584; }","duration":"202.536533ms","start":"2026-04-22T00:28:05.061312Z","end":"2026-04-22T00:28:05.263848Z","steps":["trace[224665496] 'range keys from in-memory index tree' (duration: 202.333408ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:28:05.264089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.844105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:28:05.264147Z","caller":"traceutil/trace.go:171","msg":"trace[178428189] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:584; }","duration":"174.916266ms","start":"2026-04-22T00:28:05.089215Z","end":"2026-04-22T00:28:05.264132Z","steps":["trace[178428189] 'range keys from in-memory index tree' (duration: 174.66327ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:28:05.264217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.703586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T00:28:05.264355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.99931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:28:05.264407Z","caller":"traceutil/trace.go:171","msg":"trace[1528994245] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:584; }","duration":"202.947561ms","start":"2026-04-22T00:28:05.061445Z","end":"2026-04-22T00:28:05.264392Z","steps":["trace[1528994245] 'count revisions from in-memory index tree' (duration: 202.578513ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:05.264422Z","caller":"traceutil/trace.go:171","msg":"trace[227406364] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:584; }","duration":"202.146574ms","start":"2026-04-22T00:28:05.062263Z","end":"2026-04-22T00:28:05.264409Z","steps":["trace[227406364] 'range keys from in-memory index tree' (duration: 201.879638ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:28:05.264358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.719611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T00:28:05.26448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.374377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T00:28:05.26453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.895456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:28:05.264543Z","caller":"traceutil/trace.go:171","msg":"trace[843883710] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:584; }","duration":"144.499069ms","start":"2026-04-22T00:28:05.120027Z","end":"2026-04-22T00:28:05.264526Z","steps":["trace[843883710] 'count revisions from in-memory index tree' (duration: 144.06839ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:05.264552Z","caller":"traceutil/trace.go:171","msg":"trace[212215758] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:584; }","duration":"174.909286ms","start":"2026-04-22T00:28:05.089596Z","end":"2026-04-22T00:28:05.264505Z","steps":["trace[212215758] 'range keys from in-memory index tree' (duration: 174.65388ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:05.26458Z","caller":"traceutil/trace.go:171","msg":"trace[716473960] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:584; }","duration":"143.968787ms","start":"2026-04-22T00:28:05.120597Z","end":"2026-04-22T00:28:05.264566Z","steps":["trace[716473960] 'range keys from in-memory index tree' (duration: 143.838925ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:28:05.264751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.536631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T00:28:05.26483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.521246ms","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-22T00:28:05.264814Z","caller":"traceutil/trace.go:171","msg":"trace[290202391] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:584; }","duration":"144.601372ms","start":"2026-04-22T00:28:05.120197Z","end":"2026-04-22T00:28:05.264798Z","steps":["trace[290202391] 'range keys from in-memory index tree' (duration: 144.472629ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:05.264869Z","caller":"traceutil/trace.go:171","msg":"trace[486012276] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:584; }","duration":"133.589108ms","start":"2026-04-22T00:28:05.13127Z","end":"2026-04-22T00:28:05.264859Z","steps":["trace[486012276] 'range keys from in-memory index tree' (duration: 133.391034ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:05.370253Z","caller":"traceutil/trace.go:171","msg":"trace[2056683616] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"100.998295ms","start":"2026-04-22T00:28:05.269232Z","end":"2026-04-22T00:28:05.370231Z","steps":["trace[2056683616] 'process raft request' (duration: 100.851341ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:05.420008Z","caller":"traceutil/trace.go:171","msg":"trace[921333147] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:607; }","duration":"114.972502ms","start":"2026-04-22T00:28:05.305001Z","end":"2026-04-22T00:28:05.419974Z","steps":["trace[921333147] 'read index received' (duration: 65.174065ms)","trace[921333147] 'applied index is now lower than readState.Index' (duration: 49.796837ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:28:05.430036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.861712ms","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\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:28:05.430186Z","caller":"traceutil/trace.go:171","msg":"trace[468197346] 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:586; }","duration":"125.199439ms","start":"2026-04-22T00:28:05.304968Z","end":"2026-04-22T00:28:05.430167Z","steps":["trace[468197346] 'agreement among raft nodes before linearized reading' (duration: 115.097954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:28:05.430898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.810252ms","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":"info","ts":"2026-04-22T00:28:05.430968Z","caller":"traceutil/trace.go:171","msg":"trace[514504895] 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:586; }","duration":"125.886974ms","start":"2026-04-22T00:28:05.305065Z","end":"2026-04-22T00:28:05.430952Z","steps":["trace[514504895] 'agreement among raft nodes before linearized reading' (duration: 125.807662ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:28:05.431142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.69586ms","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\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:28:05.431187Z","caller":"traceutil/trace.go:171","msg":"trace[1352795624] 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:586; }","duration":"126.128039ms","start":"2026-04-22T00:28:05.305047Z","end":"2026-04-22T00:28:05.431176Z","steps":["trace[1352795624] 'agreement among raft nodes before linearized reading' (duration: 125.67459ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:22.530342Z","caller":"traceutil/trace.go:171","msg":"trace[423989219] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"138.414839ms","start":"2026-04-22T00:28:22.3919Z","end":"2026-04-22T00:28:22.530315Z","steps":["trace[423989219] 'process raft request' (duration: 138.251355ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:28:51.256255Z","caller":"traceutil/trace.go:171","msg":"trace[1520996976] transaction","detail":"{read_only:false; response_revision:1146; number_of_response:1; }","duration":"150.838456ms","start":"2026-04-22T00:28:51.105374Z","end":"2026-04-22T00:28:51.256213Z","steps":["trace[1520996976] 'process raft request' (duration: 150.383937ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:29:11.652911Z","caller":"traceutil/trace.go:171","msg":"trace[1416337287] linearizableReadLoop","detail":"{readStateIndex:1439; appliedIndex:1438; }","duration":"207.949778ms","start":"2026-04-22T00:29:11.444923Z","end":"2026-04-22T00:29:11.652873Z","steps":["trace[1416337287] 'read index received' (duration: 150.420039ms)","trace[1416337287] 'applied index is now lower than readState.Index' (duration: 57.523758ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:29:11.652991Z","caller":"traceutil/trace.go:171","msg":"trace[1080539490] transaction","detail":"{read_only:false; response_revision:1396; number_of_response:1; }","duration":"230.482875ms","start":"2026-04-22T00:29:11.422447Z","end":"2026-04-22T00:29:11.65293Z","steps":["trace[1080539490] 'process raft request' (duration: 172.977357ms)","trace[1080539490] 'compare' (duration: 57.100359ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:29:11.653127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.190173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-22T00:29:11.653166Z","caller":"traceutil/trace.go:171","msg":"trace[290316197] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1396; }","duration":"208.307395ms","start":"2026-04-22T00:29:11.444848Z","end":"2026-04-22T00:29:11.653155Z","steps":["trace[290316197] 'agreement among raft nodes before linearized reading' (duration: 208.128451ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:29:38.596018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.26337ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T00:29:38.5962Z","caller":"traceutil/trace.go:171","msg":"trace[189827040] transaction","detail":"{read_only:false; response_revision:1821; number_of_response:1; }","duration":"319.433721ms","start":"2026-04-22T00:29:38.276739Z","end":"2026-04-22T00:29:38.596173Z","steps":["trace[189827040] 'process raft request' (duration: 80.336753ms)","trace[189827040] 'compare' (duration: 237.974444ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:29:38.59629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:29:38.276708Z","time spent":"319.540992ms","remote":"127.0.0.1:50936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T00:29:39.01639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.097901ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T00:29:39.016594Z","caller":"traceutil/trace.go:171","msg":"trace[288317406] linearizableReadLoop","detail":"{readStateIndex:1893; appliedIndex:1892; }","duration":"198.519517ms","start":"2026-04-22T00:29:38.818051Z","end":"2026-04-22T00:29:39.01657Z","steps":["trace[288317406] 'read index received' (duration: 57.201µs)","trace[288317406] 'applied index is now lower than readState.Index' (duration: 198.460556ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:29:39.016714Z","caller":"traceutil/trace.go:171","msg":"trace[1304220146] transaction","detail":"{read_only:false; response_revision:1822; number_of_response:1; }","duration":"337.83625ms","start":"2026-04-22T00:29:38.678831Z","end":"2026-04-22T00:29:39.016667Z","steps":["trace[1304220146] 'process raft request' (duration: 20.351231ms)","trace[1304220146] 'compare' (duration: 316.919377ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:29:39.016849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.795034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6dbafd04-a418-4fa6-9864-508c241a4050\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-22T00:29:39.016915Z","caller":"traceutil/trace.go:171","msg":"trace[201354967] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6dbafd04-a418-4fa6-9864-508c241a4050; range_end:; response_count:1; response_revision:1822; }","duration":"198.911726ms","start":"2026-04-22T00:29:38.817987Z","end":"2026-04-22T00:29:39.016898Z","steps":["trace[201354967] 'agreement among raft nodes before linearized reading' (duration: 198.701041ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:29:39.016925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:29:38.67879Z","time spent":"338.026385ms","remote":"127.0.0.1:50936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T00:29:39.017057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.171091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6dbafd04-a418-4fa6-9864-508c241a4050\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-22T00:29:39.017187Z","caller":"traceutil/trace.go:171","msg":"trace[326317498] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6dbafd04-a418-4fa6-9864-508c241a4050; range_end:; response_count:1; response_revision:1822; }","duration":"148.380485ms","start":"2026-04-22T00:29:38.868777Z","end":"2026-04-22T00:29:39.017157Z","steps":["trace[326317498] 'agreement among raft nodes before linearized reading' (duration: 147.967726ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:29:54.056731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.317374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-22T00:29:54.056812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.515221ms","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-22T00:29:54.056849Z","caller":"traceutil/trace.go:171","msg":"trace[1197929514] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1954; }","duration":"159.496278ms","start":"2026-04-22T00:29:53.897324Z","end":"2026-04-22T00:29:54.05682Z","steps":["trace[1197929514] 'range keys from in-memory index tree' (duration: 159.038418ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:29:54.056905Z","caller":"traceutil/trace.go:171","msg":"trace[1042128410] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1954; }","duration":"171.662924ms","start":"2026-04-22T00:29:53.885219Z","end":"2026-04-22T00:29:54.056882Z","steps":["trace[1042128410] 'range keys from in-memory index tree' (duration: 171.308807ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:28.692957Z","caller":"traceutil/trace.go:171","msg":"trace[970517691] linearizableReadLoop","detail":"{readStateIndex:2232; appliedIndex:2231; }","duration":"113.167173ms","start":"2026-04-22T00:30:28.579766Z","end":"2026-04-22T00:30:28.692933Z","steps":["trace[970517691] 'read index received' (duration: 113.00804ms)","trace[970517691] 'applied index is now lower than readState.Index' (duration: 158.283µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:30:28.692979Z","caller":"traceutil/trace.go:171","msg":"trace[992003542] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"170.860568ms","start":"2026-04-22T00:30:28.522096Z","end":"2026-04-22T00:30:28.692957Z","steps":["trace[992003542] 'process raft request' (duration: 170.690155ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:28.693115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.348386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:30:28.693157Z","caller":"traceutil/trace.go:171","msg":"trace[1161100032] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:2150; }","duration":"113.479749ms","start":"2026-04-22T00:30:28.579667Z","end":"2026-04-22T00:30:28.693147Z","steps":["trace[1161100032] 'agreement among raft nodes before linearized reading' (duration: 113.365917ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:28.913447Z","caller":"traceutil/trace.go:171","msg":"trace[1713381677] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"129.277692ms","start":"2026-04-22T00:30:28.784142Z","end":"2026-04-22T00:30:28.913419Z","steps":["trace[1713381677] 'process raft request' (duration: 129.089178ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:29.527809Z","caller":"traceutil/trace.go:171","msg":"trace[1939153154] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"161.727874ms","start":"2026-04-22T00:30:29.366052Z","end":"2026-04-22T00:30:29.52778Z","steps":["trace[1939153154] 'process raft request' (duration: 161.53633ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:29.661217Z","caller":"traceutil/trace.go:171","msg":"trace[1722675115] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"107.35607ms","start":"2026-04-22T00:30:29.553831Z","end":"2026-04-22T00:30:29.661187Z","steps":["trace[1722675115] 'process raft request' (duration: 107.302109ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:29.661316Z","caller":"traceutil/trace.go:171","msg":"trace[173129200] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"117.30304ms","start":"2026-04-22T00:30:29.543952Z","end":"2026-04-22T00:30:29.661255Z","steps":["trace[173129200] 'process raft request' (duration: 98.758649ms)","trace[173129200] 'compare' (duration: 18.250295ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:30:35.67357Z","caller":"traceutil/trace.go:171","msg":"trace[1699179564] linearizableReadLoop","detail":"{readStateIndex:2267; appliedIndex:2266; }","duration":"130.480847ms","start":"2026-04-22T00:30:35.543052Z","end":"2026-04-22T00:30:35.673532Z","steps":["trace[1699179564] 'read index received' (duration: 93.279694ms)","trace[1699179564] 'applied index is now lower than readState.Index' (duration: 37.198813ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:30:35.673708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.63139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T00:30:35.673763Z","caller":"traceutil/trace.go:171","msg":"trace[1373886595] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2183; }","duration":"130.752673ms","start":"2026-04-22T00:30:35.542996Z","end":"2026-04-22T00:30:35.673749Z","steps":["trace[1373886595] 'agreement among raft nodes before linearized reading' (duration: 130.63546ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:35.673857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.119241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-22T00:30:35.673915Z","caller":"traceutil/trace.go:171","msg":"trace[1475466875] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2183; }","duration":"122.193842ms","start":"2026-04-22T00:30:35.551707Z","end":"2026-04-22T00:30:35.673901Z","steps":["trace[1475466875] 'agreement among raft nodes before linearized reading' (duration: 122.007688ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:35.78187Z","caller":"traceutil/trace.go:171","msg":"trace[1196538557] transaction","detail":"{read_only:false; response_revision:2185; number_of_response:1; }","duration":"101.727162ms","start":"2026-04-22T00:30:35.680121Z","end":"2026-04-22T00:30:35.781848Z","steps":["trace[1196538557] 'process raft request' (duration: 101.599249ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:31:25.307867Z","caller":"traceutil/trace.go:171","msg":"trace[557525389] transaction","detail":"{read_only:false; response_revision:2626; number_of_response:1; }","duration":"144.574561ms","start":"2026-04-22T00:31:25.163261Z","end":"2026-04-22T00:31:25.307835Z","steps":["trace[557525389] 'process raft request' (duration: 144.376467ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:36:05.329189Z","caller":"traceutil/trace.go:171","msg":"trace[2100968067] transaction","detail":"{read_only:false; response_revision:5032; number_of_response:1; }","duration":"144.292362ms","start":"2026-04-22T00:36:05.184876Z","end":"2026-04-22T00:36:05.329169Z","steps":["trace[2100968067] 'process raft request' (duration: 76.13122ms)","trace[2100968067] 'compare' (duration: 67.937637ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:36:05.329152Z","caller":"traceutil/trace.go:171","msg":"trace[1703304939] linearizableReadLoop","detail":"{readStateIndex:5226; appliedIndex:5225; }","duration":"106.979122ms","start":"2026-04-22T00:36:05.222142Z","end":"2026-04-22T00:36:05.329121Z","steps":["trace[1703304939] 'read index received' (duration: 38.81897ms)","trace[1703304939] 'applied index is now lower than readState.Index' (duration: 68.158972ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:36:05.329533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.368169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:36:05.329694Z","caller":"traceutil/trace.go:171","msg":"trace[1308264423] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5032; }","duration":"107.593984ms","start":"2026-04-22T00:36:05.222081Z","end":"2026-04-22T00:36:05.329675Z","steps":["trace[1308264423] 'agreement among raft nodes before linearized reading' (duration: 107.316188ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:36:05.331694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.672367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:24 size:720276"} {"level":"info","ts":"2026-04-22T00:36:05.331781Z","caller":"traceutil/trace.go:171","msg":"trace[1357849918] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:24; response_revision:5032; }","duration":"107.809899ms","start":"2026-04-22T00:36:05.223951Z","end":"2026-04-22T00:36:05.331761Z","steps":["trace[1357849918] 'agreement among raft nodes before linearized reading' (duration: 105.576322ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:36:18.360786Z","caller":"traceutil/trace.go:171","msg":"trace[887343161] transaction","detail":"{read_only:false; response_revision:5277; number_of_response:1; }","duration":"116.181397ms","start":"2026-04-22T00:36:18.244569Z","end":"2026-04-22T00:36:18.36075Z","steps":["trace[887343161] 'process raft request' (duration: 17.50846ms)","trace[887343161] 'compare' (duration: 98.380031ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:36:18.360999Z","caller":"traceutil/trace.go:171","msg":"trace[203746056] transaction","detail":"{read_only:false; response_revision:5278; number_of_response:1; }","duration":"109.891803ms","start":"2026-04-22T00:36:18.251064Z","end":"2026-04-22T00:36:18.360956Z","steps":["trace[203746056] 'process raft request' (duration: 109.573387ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:36:33.416174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.574412ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:36:33.416664Z","caller":"traceutil/trace.go:171","msg":"trace[1080999025] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5556; }","duration":"258.120623ms","start":"2026-04-22T00:36:33.158522Z","end":"2026-04-22T00:36:33.416642Z","steps":["trace[1080999025] 'range keys from in-memory index tree' (duration: 257.552462ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:36:33.41643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.676991ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T00:36:33.417102Z","caller":"traceutil/trace.go:171","msg":"trace[1845906175] linearizableReadLoop","detail":"{readStateIndex:5765; appliedIndex:5764; }","duration":"354.760168ms","start":"2026-04-22T00:36:33.062319Z","end":"2026-04-22T00:36:33.417079Z","steps":["trace[1845906175] 'read index received' (duration: 64.288181ms)","trace[1845906175] 'applied index is now lower than readState.Index' (duration: 290.468637ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:36:33.41719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.909431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:36:33.417222Z","caller":"traceutil/trace.go:171","msg":"trace[741938490] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5557; }","duration":"354.981883ms","start":"2026-04-22T00:36:33.062229Z","end":"2026-04-22T00:36:33.417211Z","steps":["trace[741938490] 'agreement among raft nodes before linearized reading' (duration: 354.918972ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:36:33.417196Z","caller":"traceutil/trace.go:171","msg":"trace[721333331] transaction","detail":"{read_only:false; response_revision:5557; number_of_response:1; }","duration":"363.367801ms","start":"2026-04-22T00:36:33.053779Z","end":"2026-04-22T00:36:33.417147Z","steps":["trace[721333331] 'process raft request' (duration: 72.907534ms)","trace[721333331] 'compare' (duration: 289.531678ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:36:33.417253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:36:33.062207Z","time spent":"355.036734ms","remote":"127.0.0.1:51120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-04-22T00:36:33.417359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:36:33.05374Z","time spent":"363.529303ms","remote":"127.0.0.1:50852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17193,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T00:36:33.470845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.980413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T00:36:33.470967Z","caller":"traceutil/trace.go:171","msg":"trace[1246459940] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:5558; }","duration":"226.175547ms","start":"2026-04-22T00:36:33.244763Z","end":"2026-04-22T00:36:33.470938Z","steps":["trace[1246459940] 'agreement among raft nodes before linearized reading' (duration: 225.951372ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:36:33.470969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.047559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:36:33.471005Z","caller":"traceutil/trace.go:171","msg":"trace[144832916] transaction","detail":"{read_only:false; response_revision:5558; number_of_response:1; }","duration":"166.364172ms","start":"2026-04-22T00:36:33.304602Z","end":"2026-04-22T00:36:33.470966Z","steps":["trace[144832916] 'process raft request' (duration: 165.81817ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:36:33.471065Z","caller":"traceutil/trace.go:171","msg":"trace[1114150132] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5558; }","duration":"247.239654ms","start":"2026-04-22T00:36:33.223804Z","end":"2026-04-22T00:36:33.471044Z","steps":["trace[1114150132] 'agreement among raft nodes before linearized reading' (duration: 247.003668ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:36:33.470914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.980145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-ljrrp\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-22T00:36:33.471187Z","caller":"traceutil/trace.go:171","msg":"trace[188363064] range","detail":"{range_begin:/registry/pods/openstack/keepalived-ljrrp; range_end:; response_count:1; response_revision:5558; }","duration":"407.312942ms","start":"2026-04-22T00:36:33.063853Z","end":"2026-04-22T00:36:33.471166Z","steps":["trace[188363064] 'agreement among raft nodes before linearized reading' (duration: 406.888332ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:36:33.471274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:36:33.063777Z","time spent":"407.482655ms","remote":"127.0.0.1:50852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6553,"request content":"key:\"/registry/pods/openstack/keepalived-ljrrp\" "} {"level":"warn","ts":"2026-04-22T00:36:33.470903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.337939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d214b66d-0016-44a2-a081-715b65177489\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-22T00:36:33.471473Z","caller":"traceutil/trace.go:171","msg":"trace[1911490520] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d214b66d-0016-44a2-a081-715b65177489; range_end:; response_count:1; response_revision:5558; }","duration":"241.945512ms","start":"2026-04-22T00:36:33.229506Z","end":"2026-04-22T00:36:33.471451Z","steps":["trace[1911490520] 'agreement among raft nodes before linearized reading' (duration: 241.203676ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:36:33.828364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.342947ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T00:36:33.82868Z","caller":"traceutil/trace.go:171","msg":"trace[1027977955] linearizableReadLoop","detail":"{readStateIndex:5768; appliedIndex:5766; }","duration":"340.510377ms","start":"2026-04-22T00:36:33.488148Z","end":"2026-04-22T00:36:33.828658Z","steps":["trace[1027977955] 'read index received' (duration: 108.751132ms)","trace[1027977955] 'applied index is now lower than readState.Index' (duration: 231.758005ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:36:33.828697Z","caller":"traceutil/trace.go:171","msg":"trace[1651528459] transaction","detail":"{read_only:false; response_revision:5560; number_of_response:1; }","duration":"349.640471ms","start":"2026-04-22T00:36:33.479004Z","end":"2026-04-22T00:36:33.828645Z","steps":["trace[1651528459] 'process raft request' (duration: 349.491808ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:36:33.828878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:36:33.478991Z","time spent":"349.772933ms","remote":"127.0.0.1:50852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3751,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:36:33.828862Z","caller":"traceutil/trace.go:171","msg":"trace[1023984129] transaction","detail":"{read_only:false; response_revision:5559; number_of_response:1; }","duration":"350.774295ms","start":"2026-04-22T00:36:33.478051Z","end":"2026-04-22T00:36:33.828826Z","steps":["trace[1023984129] 'process raft request' (duration: 118.833895ms)","trace[1023984129] 'compare' (duration: 231.055341ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:36:33.82903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.373131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"warn","ts":"2026-04-22T00:36:33.829032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:36:33.478027Z","time spent":"350.912147ms","remote":"127.0.0.1:50936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:36:33.829073Z","caller":"traceutil/trace.go:171","msg":"trace[960824864] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5561; }","duration":"312.469663ms","start":"2026-04-22T00:36:33.516586Z","end":"2026-04-22T00:36:33.829056Z","steps":["trace[960824864] 'agreement among raft nodes before linearized reading' (duration: 312.29488ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:36:33.829101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:36:33.516553Z","time spent":"312.541985ms","remote":"127.0.0.1:50824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2105,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-04-22T00:36:33.829083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.486701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:36:33.829169Z","caller":"traceutil/trace.go:171","msg":"trace[610216571] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5561; }","duration":"266.617783ms","start":"2026-04-22T00:36:33.562528Z","end":"2026-04-22T00:36:33.829145Z","steps":["trace[610216571] 'agreement among raft nodes before linearized reading' (duration: 266.44839ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:36:33.829143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.949066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-04-22T00:36:33.829215Z","caller":"traceutil/trace.go:171","msg":"trace[275821408] transaction","detail":"{read_only:false; response_revision:5561; number_of_response:1; }","duration":"192.271539ms","start":"2026-04-22T00:36:33.636884Z","end":"2026-04-22T00:36:33.829156Z","steps":["trace[275821408] 'process raft request' (duration: 191.726668ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:36:33.829257Z","caller":"traceutil/trace.go:171","msg":"trace[791123653] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5561; }","duration":"341.099279ms","start":"2026-04-22T00:36:33.48813Z","end":"2026-04-22T00:36:33.82923Z","steps":["trace[791123653] 'agreement among raft nodes before linearized reading' (duration: 340.630069ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:36:33.829401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:36:33.488123Z","time spent":"341.261862ms","remote":"127.0.0.1:47000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5674,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-04-22T00:36:34.017153Z","caller":"traceutil/trace.go:171","msg":"trace[1811652994] linearizableReadLoop","detail":"{readStateIndex:5770; appliedIndex:5769; }","duration":"177.595ms","start":"2026-04-22T00:36:33.83953Z","end":"2026-04-22T00:36:34.017125Z","steps":["trace[1811652994] 'read index received' (duration: 104.088323ms)","trace[1811652994] 'applied index is now lower than readState.Index' (duration: 73.505567ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:36:34.017212Z","caller":"traceutil/trace.go:171","msg":"trace[1442393484] transaction","detail":"{read_only:false; response_revision:5562; number_of_response:1; }","duration":"183.336851ms","start":"2026-04-22T00:36:33.833831Z","end":"2026-04-22T00:36:34.017167Z","steps":["trace[1442393484] 'process raft request' (duration: 109.63301ms)","trace[1442393484] 'compare' (duration: 73.519596ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:36:34.017487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.914496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-04-22T00:36:34.017597Z","caller":"traceutil/trace.go:171","msg":"trace[1584094114] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5562; }","duration":"178.0925ms","start":"2026-04-22T00:36:33.839479Z","end":"2026-04-22T00:36:34.017572Z","steps":["trace[1584094114] 'agreement among raft nodes before linearized reading' (duration: 177.751393ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:36:34.02328Z","caller":"traceutil/trace.go:171","msg":"trace[860276522] transaction","detail":"{read_only:false; response_revision:5563; number_of_response:1; }","duration":"175.674428ms","start":"2026-04-22T00:36:33.847578Z","end":"2026-04-22T00:36:34.023252Z","steps":["trace[860276522] 'process raft request' (duration: 175.345721ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:36:44.660399Z","caller":"traceutil/trace.go:171","msg":"trace[2051051808] transaction","detail":"{read_only:false; response_revision:5655; number_of_response:1; }","duration":"117.045898ms","start":"2026-04-22T00:36:44.543314Z","end":"2026-04-22T00:36:44.66036Z","steps":["trace[2051051808] 'process raft request' (duration: 116.729741ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:36:44.796551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.031078ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T00:36:44.796948Z","caller":"traceutil/trace.go:171","msg":"trace[2080031417] transaction","detail":"{read_only:false; response_revision:5660; number_of_response:1; }","duration":"125.921146ms","start":"2026-04-22T00:36:44.671003Z","end":"2026-04-22T00:36:44.796924Z","steps":["trace[2080031417] 'process raft request' (duration: 125.810613ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:36:44.797107Z","caller":"traceutil/trace.go:171","msg":"trace[467282884] transaction","detail":"{read_only:false; response_revision:5659; number_of_response:1; }","duration":"126.209761ms","start":"2026-04-22T00:36:44.670847Z","end":"2026-04-22T00:36:44.797056Z","steps":["trace[467282884] 'process raft request' (duration: 125.923345ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:36:44.797176Z","caller":"traceutil/trace.go:171","msg":"trace[97569418] transaction","detail":"{read_only:false; response_revision:5658; number_of_response:1; }","duration":"126.491578ms","start":"2026-04-22T00:36:44.670653Z","end":"2026-04-22T00:36:44.797144Z","steps":["trace[97569418] 'process raft request' (duration: 126.035248ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:36:44.79711Z","caller":"traceutil/trace.go:171","msg":"trace[528145643] transaction","detail":"{read_only:false; response_revision:5657; number_of_response:1; }","duration":"129.667015ms","start":"2026-04-22T00:36:44.667395Z","end":"2026-04-22T00:36:44.797062Z","steps":["trace[528145643] 'process raft request' (duration: 20.017614ms)","trace[528145643] 'compare' (duration: 108.889315ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:36:44.797414Z","caller":"traceutil/trace.go:171","msg":"trace[932900781] transaction","detail":"{read_only:false; response_revision:5661; number_of_response:1; }","duration":"125.412594ms","start":"2026-04-22T00:36:44.671989Z","end":"2026-04-22T00:36:44.797401Z","steps":["trace[932900781] 'process raft request' (duration: 124.891814ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:36:44.797642Z","caller":"traceutil/trace.go:171","msg":"trace[1430951240] transaction","detail":"{read_only:false; response_revision:5662; number_of_response:1; }","duration":"118.305134ms","start":"2026-04-22T00:36:44.679323Z","end":"2026-04-22T00:36:44.797628Z","steps":["trace[1430951240] 'process raft request' (duration: 118.000078ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:36:45.273959Z","caller":"traceutil/trace.go:171","msg":"trace[1824869887] linearizableReadLoop","detail":"{readStateIndex:5874; appliedIndex:5873; }","duration":"340.523618ms","start":"2026-04-22T00:36:44.933399Z","end":"2026-04-22T00:36:45.273923Z","steps":["trace[1824869887] 'read index received' (duration: 340.144951ms)","trace[1824869887] 'applied index is now lower than readState.Index' (duration: 376.187µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:36:45.274076Z","caller":"traceutil/trace.go:171","msg":"trace[2073818849] transaction","detail":"{read_only:false; response_revision:5663; number_of_response:1; }","duration":"469.64247ms","start":"2026-04-22T00:36:44.804381Z","end":"2026-04-22T00:36:45.274023Z","steps":["trace[2073818849] 'process raft request' (duration: 469.263553ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:36:45.274327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:36:44.804348Z","time spent":"469.843675ms","remote":"127.0.0.1:50936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T00:36:45.274496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.070919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T00:36:45.274576Z","caller":"traceutil/trace.go:171","msg":"trace[1306052910] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:5663; }","duration":"341.214753ms","start":"2026-04-22T00:36:44.933344Z","end":"2026-04-22T00:36:45.274559Z","steps":["trace[1306052910] 'agreement among raft nodes before linearized reading' (duration: 340.749373ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:36:45.274626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:36:44.933322Z","time spent":"341.292564ms","remote":"127.0.0.1:50842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":30,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"info","ts":"2026-04-22T00:37:27.037306Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2983} {"level":"info","ts":"2026-04-22T00:37:27.111842Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2983,"took":"72.802271ms","hash":1960791427,"current-db-size-bytes":57610240,"current-db-size":"58 MB","current-db-size-in-use-bytes":33390592,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-22T00:37:27.111902Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1960791427,"revision":2983,"compact-revision":-1} {"level":"info","ts":"2026-04-22T00:42:27.043641Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6012} {"level":"info","ts":"2026-04-22T00:42:27.142332Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6012,"took":"96.502256ms","hash":2104824812,"current-db-size-bytes":57610240,"current-db-size":"58 MB","current-db-size-in-use-bytes":21471232,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-22T00:42:27.14242Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2104824812,"revision":6012,"compact-revision":2983} {"level":"info","ts":"2026-04-22T00:42:52.440183Z","caller":"traceutil/trace.go:171","msg":"trace[1626145287] transaction","detail":"{read_only:false; response_revision:8389; number_of_response:1; }","duration":"218.577437ms","start":"2026-04-22T00:42:52.22158Z","end":"2026-04-22T00:42:52.440158Z","steps":["trace[1626145287] 'process raft request' (duration: 218.406563ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:42:52.576268Z","caller":"traceutil/trace.go:171","msg":"trace[2063927897] transaction","detail":"{read_only:false; response_revision:8390; number_of_response:1; }","duration":"252.212101ms","start":"2026-04-22T00:42:52.324011Z","end":"2026-04-22T00:42:52.576224Z","steps":["trace[2063927897] 'process raft request' (duration: 245.228274ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:43:04.340541Z","caller":"traceutil/trace.go:171","msg":"trace[1424972855] linearizableReadLoop","detail":"{readStateIndex:8755; appliedIndex:8754; }","duration":"221.442008ms","start":"2026-04-22T00:43:04.119063Z","end":"2026-04-22T00:43:04.340505Z","steps":["trace[1424972855] 'read index received' (duration: 129.708382ms)","trace[1424972855] 'applied index is now lower than readState.Index' (duration: 91.731966ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:43:04.340644Z","caller":"traceutil/trace.go:171","msg":"trace[1188299296] transaction","detail":"{read_only:false; response_revision:8451; number_of_response:1; }","duration":"347.256308ms","start":"2026-04-22T00:43:03.993303Z","end":"2026-04-22T00:43:04.340559Z","steps":["trace[1188299296] 'process raft request' (duration: 255.48407ms)","trace[1188299296] 'compare' (duration: 91.474881ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:43:04.340803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.053823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T00:43:04.340835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.749214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-22T00:43:04.340909Z","caller":"traceutil/trace.go:171","msg":"trace[1510975210] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8451; }","duration":"116.200666ms","start":"2026-04-22T00:43:04.224679Z","end":"2026-04-22T00:43:04.34088Z","steps":["trace[1510975210] 'agreement among raft nodes before linearized reading' (duration: 116.017902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:43:04.340924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:43:03.99327Z","time spent":"347.509862ms","remote":"127.0.0.1:50936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:43:04.340942Z","caller":"traceutil/trace.go:171","msg":"trace[981965365] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8451; }","duration":"221.930768ms","start":"2026-04-22T00:43:04.118987Z","end":"2026-04-22T00:43:04.340918Z","steps":["trace[981965365] 'agreement among raft nodes before linearized reading' (duration: 221.639592ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:43:05.224982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.701677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T00:43:05.225045Z","caller":"traceutil/trace.go:171","msg":"trace[1998309766] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:8456; }","duration":"175.816089ms","start":"2026-04-22T00:43:05.049216Z","end":"2026-04-22T00:43:05.225032Z","steps":["trace[1998309766] 'count revisions from in-memory index tree' (duration: 175.633696ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:43:05.225342Z","caller":"traceutil/trace.go:171","msg":"trace[1956076660] transaction","detail":"{read_only:false; response_revision:8457; number_of_response:1; }","duration":"141.90836ms","start":"2026-04-22T00:43:05.083381Z","end":"2026-04-22T00:43:05.225289Z","steps":["trace[1956076660] 'process raft request' (duration: 134.249818ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:43:05.846219Z","caller":"traceutil/trace.go:171","msg":"trace[838389865] transaction","detail":"{read_only:false; response_revision:8460; number_of_response:1; }","duration":"116.640974ms","start":"2026-04-22T00:43:05.729549Z","end":"2026-04-22T00:43:05.84619Z","steps":["trace[838389865] 'process raft request' (duration: 116.167285ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:43:06.5496Z","caller":"traceutil/trace.go:171","msg":"trace[1262584239] transaction","detail":"{read_only:false; response_revision:8462; number_of_response:1; }","duration":"164.863758ms","start":"2026-04-22T00:43:06.38469Z","end":"2026-04-22T00:43:06.549554Z","steps":["trace[1262584239] 'process raft request' (duration: 129.420746ms)","trace[1262584239] 'compare' (duration: 35.052583ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:43:34.882358Z","caller":"traceutil/trace.go:171","msg":"trace[999172364] transaction","detail":"{read_only:false; response_revision:8669; number_of_response:1; }","duration":"417.073098ms","start":"2026-04-22T00:43:34.465254Z","end":"2026-04-22T00:43:34.882327Z","steps":["trace[999172364] 'process raft request' (duration: 416.868604ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:43:34.882586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:43:34.465224Z","time spent":"417.248972ms","remote":"127.0.0.1:50936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:43:34.889214Z","caller":"traceutil/trace.go:171","msg":"trace[229398388] transaction","detail":"{read_only:false; response_revision:8670; number_of_response:1; }","duration":"206.857388ms","start":"2026-04-22T00:43:34.68233Z","end":"2026-04-22T00:43:34.889187Z","steps":["trace[229398388] 'process raft request' (duration: 206.572931ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:43:34.889191Z","caller":"traceutil/trace.go:171","msg":"trace[1917803544] linearizableReadLoop","detail":"{readStateIndex:8983; appliedIndex:8981; }","duration":"193.322842ms","start":"2026-04-22T00:43:34.695844Z","end":"2026-04-22T00:43:34.889167Z","steps":["trace[1917803544] 'read index received' (duration: 186.368884ms)","trace[1917803544] 'applied index is now lower than readState.Index' (duration: 6.952508ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:43:34.88935Z","caller":"traceutil/trace.go:171","msg":"trace[874460475] transaction","detail":"{read_only:false; response_revision:8671; number_of_response:1; }","duration":"149.905241ms","start":"2026-04-22T00:43:34.739398Z","end":"2026-04-22T00:43:34.889304Z","steps":["trace[874460475] 'process raft request' (duration: 149.712666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:43:34.889444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.593477ms","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-22T00:43:34.889483Z","caller":"traceutil/trace.go:171","msg":"trace[496674235] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8671; }","duration":"193.668739ms","start":"2026-04-22T00:43:34.695804Z","end":"2026-04-22T00:43:34.889473Z","steps":["trace[496674235] 'agreement among raft nodes before linearized reading' (duration: 193.552977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:43:34.889741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.600976ms","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-22T00:43:34.889925Z","caller":"traceutil/trace.go:171","msg":"trace[732422129] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8671; }","duration":"192.822111ms","start":"2026-04-22T00:43:34.697089Z","end":"2026-04-22T00:43:34.889911Z","steps":["trace[732422129] 'agreement among raft nodes before linearized reading' (duration: 192.406833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:43:47.64526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.310393ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T00:43:47.645869Z","caller":"traceutil/trace.go:171","msg":"trace[1520087773] transaction","detail":"{read_only:false; response_revision:8782; number_of_response:1; }","duration":"154.884715ms","start":"2026-04-22T00:43:47.490964Z","end":"2026-04-22T00:43:47.645849Z","steps":["trace[1520087773] 'compare' (duration: 144.114818ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:43:47.832338Z","caller":"traceutil/trace.go:171","msg":"trace[459659486] linearizableReadLoop","detail":"{readStateIndex:9103; appliedIndex:9102; }","duration":"101.77058ms","start":"2026-04-22T00:43:47.730536Z","end":"2026-04-22T00:43:47.832306Z","steps":["trace[459659486] 'read index received' (duration: 29.359274ms)","trace[459659486] 'applied index is now lower than readState.Index' (duration: 72.410026ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:43:47.832452Z","caller":"traceutil/trace.go:171","msg":"trace[939435282] transaction","detail":"{read_only:false; response_revision:8784; number_of_response:1; }","duration":"179.956288ms","start":"2026-04-22T00:43:47.65245Z","end":"2026-04-22T00:43:47.832406Z","steps":["trace[939435282] 'process raft request' (duration: 107.51654ms)","trace[939435282] 'compare' (duration: 72.189112ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:43:47.832686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.025025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T00:43:47.832745Z","caller":"traceutil/trace.go:171","msg":"trace[507536917] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:8784; }","duration":"102.25684ms","start":"2026-04-22T00:43:47.730469Z","end":"2026-04-22T00:43:47.832726Z","steps":["trace[507536917] 'agreement among raft nodes before linearized reading' (duration: 102.016835ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:44:30.947845Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000251e.wal"} {"level":"info","ts":"2026-04-22T00:45:20.528549Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"9ef3b4f68930dc2","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-22T00:45:20.535098Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-22T00:45:20.535205Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-22T00:47:27.05094Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8077} {"level":"info","ts":"2026-04-22T00:47:27.120294Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8077,"took":"67.078774ms","hash":2422698459,"current-db-size-bytes":57610240,"current-db-size":"58 MB","current-db-size-in-use-bytes":27688960,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-04-22T00:47:27.120376Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2422698459,"revision":8077,"compact-revision":6012} {"level":"info","ts":"2026-04-22T00:52:27.058559Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10486} {"level":"info","ts":"2026-04-22T00:52:27.143002Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10486,"took":"81.824875ms","hash":3695932681,"current-db-size-bytes":57610240,"current-db-size":"58 MB","current-db-size-in-use-bytes":21639168,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-22T00:52:27.143083Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3695932681,"revision":10486,"compact-revision":8077}