{"level":"warn","ts":"2026-07-21T06:36:34.927066Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-21T06:36:34.927173Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.103: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.103:2380","--initial-cluster=instance=https://199.19.213.103:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.103:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.103: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-07-21T06:36:34.927259Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-21T06:36:34.927271Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.103:2380"]} {"level":"info","ts":"2026-07-21T06:36:34.927295Z","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-07-21T06:36:34.928614Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.103:2379"]} {"level":"info","ts":"2026-07-21T06:36:34.928743Z","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.103:2380"],"listen-peer-urls":["https://199.19.213.103:2380"],"advertise-client-urls":["https://199.19.213.103:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.103:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.103: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-07-21T06:36:34.935004Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.698765ms"} {"level":"info","ts":"2026-07-21T06:36:34.941711Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d82047944f922143","cluster-id":"223a09c0da413f53"} {"level":"info","ts":"2026-07-21T06:36:34.941782Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d82047944f922143 switched to configuration voters=()"} {"level":"info","ts":"2026-07-21T06:36:34.941805Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d82047944f922143 became follower at term 0"} {"level":"info","ts":"2026-07-21T06:36:34.941821Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d82047944f922143 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-21T06:36:34.941835Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d82047944f922143 became follower at term 1"} {"level":"info","ts":"2026-07-21T06:36:34.941874Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d82047944f922143 switched to configuration voters=(15573526213762883907)"} {"level":"warn","ts":"2026-07-21T06:36:34.947396Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-21T06:36:34.9491Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-21T06:36:34.950448Z","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-07-21T06:36:34.952656Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d82047944f922143","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-21T06:36:34.954075Z","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-07-21T06:36:34.954092Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d82047944f922143","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-21T06:36:34.954185Z","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-07-21T06:36:34.954198Z","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-07-21T06:36:34.956149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d82047944f922143 switched to configuration voters=(15573526213762883907)"} {"level":"info","ts":"2026-07-21T06:36:34.956275Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"223a09c0da413f53","local-member-id":"d82047944f922143","added-peer-id":"d82047944f922143","added-peer-peer-urls":["https://199.19.213.103:2380"]} {"level":"info","ts":"2026-07-21T06:36:34.959326Z","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-07-21T06:36:34.9595Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.103:2380"} {"level":"info","ts":"2026-07-21T06:36:34.959555Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.103:2380"} {"level":"info","ts":"2026-07-21T06:36:34.959773Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d82047944f922143","initial-advertise-peer-urls":["https://199.19.213.103:2380"],"listen-peer-urls":["https://199.19.213.103:2380"],"advertise-client-urls":["https://199.19.213.103:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.103:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-21T06:36:34.959856Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-21T06:36:35.442478Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d82047944f922143 is starting a new election at term 1"} {"level":"info","ts":"2026-07-21T06:36:35.442548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d82047944f922143 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-21T06:36:35.442591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d82047944f922143 received MsgPreVoteResp from d82047944f922143 at term 1"} {"level":"info","ts":"2026-07-21T06:36:35.442627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d82047944f922143 became candidate at term 2"} {"level":"info","ts":"2026-07-21T06:36:35.442647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d82047944f922143 received MsgVoteResp from d82047944f922143 at term 2"} {"level":"info","ts":"2026-07-21T06:36:35.442664Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d82047944f922143 became leader at term 2"} {"level":"info","ts":"2026-07-21T06:36:35.44268Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d82047944f922143 elected leader d82047944f922143 at term 2"} {"level":"info","ts":"2026-07-21T06:36:35.444761Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-21T06:36:35.445691Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d82047944f922143","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.103:2379]}","request-path":"/0/members/d82047944f922143/attributes","cluster-id":"223a09c0da413f53","publish-timeout":"7s"} {"level":"info","ts":"2026-07-21T06:36:35.445833Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-21T06:36:35.446107Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-21T06:36:35.448132Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.103:2379"} {"level":"info","ts":"2026-07-21T06:36:35.448806Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-21T06:36:35.456223Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-21T06:36:35.456271Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-21T06:36:35.456517Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"223a09c0da413f53","local-member-id":"d82047944f922143","cluster-version":"3.5"} {"level":"info","ts":"2026-07-21T06:36:35.456598Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-21T06:36:35.456624Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-21T06:36:38.128993Z","caller":"traceutil/trace.go:171","msg":"trace[143050647] transaction","detail":"{read_only:false; response_revision:93; number_of_response:1; }","duration":"106.226739ms","start":"2026-07-21T06:36:38.022714Z","end":"2026-07-21T06:36:38.12894Z","steps":["trace[143050647] 'process raft request' (duration: 24.95779ms)","trace[143050647] 'compare' (duration: 81.094955ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T06:37:15.13939Z","caller":"traceutil/trace.go:171","msg":"trace[300002079] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"226.701267ms","start":"2026-07-21T06:37:14.912669Z","end":"2026-07-21T06:37:15.13937Z","steps":["trace[300002079] 'process raft request' (duration: 143.685681ms)","trace[300002079] 'compare' (duration: 82.834831ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T06:37:15.143455Z","caller":"traceutil/trace.go:171","msg":"trace[656992522] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"216.892881ms","start":"2026-07-21T06:37:14.926541Z","end":"2026-07-21T06:37:15.143434Z","steps":["trace[656992522] 'process raft request' (duration: 216.354287ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T06:37:15.296544Z","caller":"traceutil/trace.go:171","msg":"trace[444121530] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"115.903765ms","start":"2026-07-21T06:37:15.180598Z","end":"2026-07-21T06:37:15.296502Z","steps":["trace[444121530] 'process raft request' (duration: 67.009259ms)","trace[444121530] 'compare' (duration: 48.600087ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T06:37:15.312177Z","caller":"traceutil/trace.go:171","msg":"trace[710200921] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"109.364967ms","start":"2026-07-21T06:37:15.202266Z","end":"2026-07-21T06:37:15.311631Z","steps":["trace[710200921] 'process raft request' (duration: 102.461568ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T06:37:15.575654Z","caller":"traceutil/trace.go:171","msg":"trace[204104921] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"194.125229ms","start":"2026-07-21T06:37:15.381508Z","end":"2026-07-21T06:37:15.575633Z","steps":["trace[204104921] 'process raft request' (duration: 99.152346ms)","trace[204104921] 'compare' (duration: 94.749527ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T06:37:15.575956Z","caller":"traceutil/trace.go:171","msg":"trace[401207928] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"185.985938ms","start":"2026-07-21T06:37:15.389959Z","end":"2026-07-21T06:37:15.575945Z","steps":["trace[401207928] 'process raft request' (duration: 185.634088ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T06:37:15.576085Z","caller":"traceutil/trace.go:171","msg":"trace[2142605] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"163.512654ms","start":"2026-07-21T06:37:15.412531Z","end":"2026-07-21T06:37:15.576044Z","steps":["trace[2142605] 'process raft request' (duration: 163.34786ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T06:37:23.93513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.139339ms","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-07-21T06:37:23.935248Z","caller":"traceutil/trace.go:171","msg":"trace[431365013] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:691; }","duration":"169.303484ms","start":"2026-07-21T06:37:23.765925Z","end":"2026-07-21T06:37:23.935229Z","steps":["trace[431365013] 'range keys from in-memory index tree' (duration: 168.933663ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T06:37:24.388533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.312181ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-21T06:37:24.388828Z","caller":"traceutil/trace.go:171","msg":"trace[448574318] linearizableReadLoop","detail":"{readStateIndex:718; appliedIndex:717; }","duration":"291.360866ms","start":"2026-07-21T06:37:24.097426Z","end":"2026-07-21T06:37:24.388787Z","steps":["trace[448574318] 'read index received' (duration: 62.668395ms)","trace[448574318] 'applied index is now lower than readState.Index' (duration: 228.689311ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T06:37:24.389114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.656804ms","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-07-21T06:37:24.389202Z","caller":"traceutil/trace.go:171","msg":"trace[1047535168] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:692; }","duration":"291.789027ms","start":"2026-07-21T06:37:24.097394Z","end":"2026-07-21T06:37:24.389183Z","steps":["trace[1047535168] 'agreement among raft nodes before linearized reading' (duration: 291.496409ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T06:37:24.389344Z","caller":"traceutil/trace.go:171","msg":"trace[428789970] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"212.857456ms","start":"2026-07-21T06:37:24.176442Z","end":"2026-07-21T06:37:24.389299Z","steps":["trace[428789970] 'process raft request' (duration: 212.337871ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T06:37:24.802936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.863717ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-21T06:37:24.803069Z","caller":"traceutil/trace.go:171","msg":"trace[161847693] linearizableReadLoop","detail":"{readStateIndex:723; appliedIndex:722; }","duration":"242.956314ms","start":"2026-07-21T06:37:24.56009Z","end":"2026-07-21T06:37:24.803047Z","steps":["trace[161847693] 'read index received' (duration: 38.261µs)","trace[161847693] 'applied index is now lower than readState.Index' (duration: 242.916333ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T06:37:24.803169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.099478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T06:37:24.803207Z","caller":"traceutil/trace.go:171","msg":"trace[1207968072] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:697; }","duration":"243.240872ms","start":"2026-07-21T06:37:24.559956Z","end":"2026-07-21T06:37:24.803197Z","steps":["trace[1207968072] 'agreement among raft nodes before linearized reading' (duration: 243.15728ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T06:37:24.803334Z","caller":"traceutil/trace.go:171","msg":"trace[991512384] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"354.152402ms","start":"2026-07-21T06:37:24.44891Z","end":"2026-07-21T06:37:24.803063Z","steps":["trace[991512384] 'process raft request' (duration: 40.7393ms)","trace[991512384] 'compare' (duration: 312.643691ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T06:37:24.803551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T06:37:24.448891Z","time spent":"354.506551ms","remote":"127.0.0.1:40272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-21T06:37:40.959001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.336202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9plzr\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-07-21T06:37:40.959134Z","caller":"traceutil/trace.go:171","msg":"trace[1626616565] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9plzr; range_end:; response_count:1; response_revision:817; }","duration":"227.509857ms","start":"2026-07-21T06:37:40.731603Z","end":"2026-07-21T06:37:40.959113Z","steps":["trace[1626616565] 'range keys from in-memory index tree' (duration: 227.164757ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T06:38:35.139926Z","caller":"traceutil/trace.go:171","msg":"trace[1720212711] transaction","detail":"{read_only:false; response_revision:1483; number_of_response:1; }","duration":"115.458831ms","start":"2026-07-21T06:38:35.024431Z","end":"2026-07-21T06:38:35.13989Z","steps":["trace[1720212711] 'process raft request' (duration: 88.31671ms)","trace[1720212711] 'compare' (duration: 26.962606ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T06:39:01.679828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.886728ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-21T06:39:01.679948Z","caller":"traceutil/trace.go:171","msg":"trace[396037044] linearizableReadLoop","detail":"{readStateIndex:1971; appliedIndex:1970; }","duration":"320.176048ms","start":"2026-07-21T06:39:01.359752Z","end":"2026-07-21T06:39:01.679928Z","steps":["trace[396037044] 'read index received' (duration: 64.532µs)","trace[396037044] 'applied index is now lower than readState.Index' (duration: 320.110126ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T06:39:01.679996Z","caller":"traceutil/trace.go:171","msg":"trace[1099030279] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"368.491388ms","start":"2026-07-21T06:39:01.311469Z","end":"2026-07-21T06:39:01.679961Z","steps":["trace[1099030279] 'process raft request' (duration: 19.221639ms)","trace[1099030279] 'compare' (duration: 348.778705ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T06:39:01.68013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.257174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-21T06:39:01.680179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T06:39:01.311447Z","time spent":"368.658363ms","remote":"127.0.0.1:40034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T06:39:01.680186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.433326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-07-21T06:39:01.680193Z","caller":"traceutil/trace.go:171","msg":"trace[1253737308] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1895; }","duration":"121.354357ms","start":"2026-07-21T06:39:01.558822Z","end":"2026-07-21T06:39:01.680176Z","steps":["trace[1253737308] 'agreement among raft nodes before linearized reading' (duration: 121.237744ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T06:39:01.680233Z","caller":"traceutil/trace.go:171","msg":"trace[81469061] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1895; }","duration":"320.525798ms","start":"2026-07-21T06:39:01.359693Z","end":"2026-07-21T06:39:01.680219Z","steps":["trace[81469061] 'agreement among raft nodes before linearized reading' (duration: 320.337213ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T06:39:01.680271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T06:39:01.35967Z","time spent":"320.59189ms","remote":"127.0.0.1:41422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-07-21T06:39:02.18757Z","caller":"traceutil/trace.go:171","msg":"trace[577520289] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"104.449684ms","start":"2026-07-21T06:39:02.083094Z","end":"2026-07-21T06:39:02.187543Z","steps":["trace[577520289] 'process raft request' (duration: 104.290189ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T06:39:30.779579Z","caller":"traceutil/trace.go:171","msg":"trace[189355890] transaction","detail":"{read_only:false; response_revision:2108; number_of_response:1; }","duration":"127.558671ms","start":"2026-07-21T06:39:30.651998Z","end":"2026-07-21T06:39:30.779557Z","steps":["trace[189355890] 'process raft request' (duration: 127.408508ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T06:39:37.181906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.824423ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-21T06:39:37.182117Z","caller":"traceutil/trace.go:171","msg":"trace[605212628] linearizableReadLoop","detail":"{readStateIndex:2226; appliedIndex:2224; }","duration":"263.752879ms","start":"2026-07-21T06:39:36.918346Z","end":"2026-07-21T06:39:37.182099Z","steps":["trace[605212628] 'read index received' (duration: 48.68239ms)","trace[605212628] 'applied index is now lower than readState.Index' (duration: 215.069119ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T06:39:37.182284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.932533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-07-21T06:39:37.182254Z","caller":"traceutil/trace.go:171","msg":"trace[1017011886] transaction","detail":"{read_only:false; response_revision:2143; number_of_response:1; }","duration":"273.910056ms","start":"2026-07-21T06:39:36.9083Z","end":"2026-07-21T06:39:37.18221Z","steps":["trace[1017011886] 'process raft request' (duration: 273.748163ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T06:39:37.182314Z","caller":"traceutil/trace.go:171","msg":"trace[1648265655] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2143; }","duration":"263.986774ms","start":"2026-07-21T06:39:36.918318Z","end":"2026-07-21T06:39:37.182305Z","steps":["trace[1648265655] 'agreement among raft nodes before linearized reading' (duration: 263.846991ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T06:39:37.182364Z","caller":"traceutil/trace.go:171","msg":"trace[179628376] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"284.190835ms","start":"2026-07-21T06:39:36.898107Z","end":"2026-07-21T06:39:37.182298Z","steps":["trace[179628376] 'process raft request' (duration: 68.896312ms)","trace[179628376] 'compare' (duration: 214.717251ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T06:39:37.42887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.332487ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-21T06:39:37.429296Z","caller":"traceutil/trace.go:171","msg":"trace[1262137579] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"182.877223ms","start":"2026-07-21T06:39:37.246388Z","end":"2026-07-21T06:39:37.429265Z","steps":["trace[1262137579] 'process raft request' (duration: 37.058067ms)","trace[1262137579] 'compare' (duration: 145.195924ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T06:39:37.429474Z","caller":"traceutil/trace.go:171","msg":"trace[269801046] linearizableReadLoop","detail":"{readStateIndex:2229; appliedIndex:2228; }","duration":"162.223332ms","start":"2026-07-21T06:39:37.267117Z","end":"2026-07-21T06:39:37.42934Z","steps":["trace[269801046] 'read index received' (duration: 16.245422ms)","trace[269801046] 'applied index is now lower than readState.Index' (duration: 145.97193ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T06:39:37.42956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.422296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T06:39:37.429595Z","caller":"traceutil/trace.go:171","msg":"trace[868463524] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:2146; }","duration":"162.511848ms","start":"2026-07-21T06:39:37.267074Z","end":"2026-07-21T06:39:37.429586Z","steps":["trace[868463524] 'agreement among raft nodes before linearized reading' (duration: 162.430846ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T06:40:42.538748Z","caller":"traceutil/trace.go:171","msg":"trace[1151711182] linearizableReadLoop","detail":"{readStateIndex:2697; appliedIndex:2696; }","duration":"126.406261ms","start":"2026-07-21T06:40:42.412319Z","end":"2026-07-21T06:40:42.538725Z","steps":["trace[1151711182] 'read index received' (duration: 126.329019ms)","trace[1151711182] 'applied index is now lower than readState.Index' (duration: 76.452µs)"],"step_count":2} {"level":"info","ts":"2026-07-21T06:40:42.538919Z","caller":"traceutil/trace.go:171","msg":"trace[641466884] transaction","detail":"{read_only:false; response_revision:2599; number_of_response:1; }","duration":"159.649397ms","start":"2026-07-21T06:40:42.379217Z","end":"2026-07-21T06:40:42.538867Z","steps":["trace[641466884] 'process raft request' (duration: 159.366131ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T06:40:42.538992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.659646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"warn","ts":"2026-07-21T06:40:42.53907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.689893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T06:40:42.539157Z","caller":"traceutil/trace.go:171","msg":"trace[892440433] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2599; }","duration":"126.869982ms","start":"2026-07-21T06:40:42.412277Z","end":"2026-07-21T06:40:42.539147Z","steps":["trace[892440433] 'agreement among raft nodes before linearized reading' (duration: 126.585705ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T06:40:42.539193Z","caller":"traceutil/trace.go:171","msg":"trace[1404444931] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:2599; }","duration":"101.895898ms","start":"2026-07-21T06:40:42.43727Z","end":"2026-07-21T06:40:42.539166Z","steps":["trace[1404444931] 'agreement among raft nodes before linearized reading' (duration: 101.671153ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T06:41:13.72091Z","caller":"traceutil/trace.go:171","msg":"trace[224732860] linearizableReadLoop","detail":"{readStateIndex:2874; appliedIndex:2873; }","duration":"128.484162ms","start":"2026-07-21T06:41:13.592398Z","end":"2026-07-21T06:41:13.720882Z","steps":["trace[224732860] 'read index received' (duration: 128.368769ms)","trace[224732860] 'applied index is now lower than readState.Index' (duration: 114.213µs)"],"step_count":2} {"level":"info","ts":"2026-07-21T06:41:13.721365Z","caller":"traceutil/trace.go:171","msg":"trace[379291895] transaction","detail":"{read_only:false; response_revision:2769; number_of_response:1; }","duration":"136.306151ms","start":"2026-07-21T06:41:13.585047Z","end":"2026-07-21T06:41:13.721353Z","steps":["trace[379291895] 'process raft request' (duration: 135.674616ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T06:41:13.72167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.24836ms","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-07-21T06:41:13.72171Z","caller":"traceutil/trace.go:171","msg":"trace[1568403882] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2769; }","duration":"129.345263ms","start":"2026-07-21T06:41:13.592353Z","end":"2026-07-21T06:41:13.721699Z","steps":["trace[1568403882] 'agreement among raft nodes before linearized reading' (duration: 129.265681ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T06:41:13.907435Z","caller":"traceutil/trace.go:171","msg":"trace[331413718] transaction","detail":"{read_only:false; response_revision:2770; number_of_response:1; }","duration":"181.058039ms","start":"2026-07-21T06:41:13.726338Z","end":"2026-07-21T06:41:13.907396Z","steps":["trace[331413718] 'process raft request' (duration: 178.788554ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T06:41:13.907563Z","caller":"traceutil/trace.go:171","msg":"trace[1271921711] linearizableReadLoop","detail":"{readStateIndex:2875; appliedIndex:2874; }","duration":"103.27962ms","start":"2026-07-21T06:41:13.804268Z","end":"2026-07-21T06:41:13.907548Z","steps":["trace[1271921711] 'read index received' (duration: 101.070356ms)","trace[1271921711] 'applied index is now lower than readState.Index' (duration: 2.208374ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T06:41:13.90802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.735001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-21T06:41:13.908049Z","caller":"traceutil/trace.go:171","msg":"trace[1931178600] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2771; }","duration":"103.816213ms","start":"2026-07-21T06:41:13.804225Z","end":"2026-07-21T06:41:13.908041Z","steps":["trace[1931178600] 'agreement among raft nodes before linearized reading' (duration: 103.623908ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T06:41:19.110887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.287359ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-21T06:41:19.111018Z","caller":"traceutil/trace.go:171","msg":"trace[1662578412] transaction","detail":"{read_only:false; response_revision:2800; number_of_response:1; }","duration":"130.211704ms","start":"2026-07-21T06:41:18.980787Z","end":"2026-07-21T06:41:19.110999Z","steps":["trace[1662578412] 'process raft request' (duration: 12.70949ms)","trace[1662578412] 'compare' (duration: 117.128195ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T06:45:00.575124Z","caller":"traceutil/trace.go:171","msg":"trace[1018786634] transaction","detail":"{read_only:false; response_revision:4411; number_of_response:1; }","duration":"122.598641ms","start":"2026-07-21T06:45:00.452498Z","end":"2026-07-21T06:45:00.575096Z","steps":["trace[1018786634] 'process raft request' (duration: 35.671449ms)","trace[1018786634] 'compare' (duration: 86.555691ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T06:45:00.575666Z","caller":"traceutil/trace.go:171","msg":"trace[1265817072] transaction","detail":"{read_only:false; response_revision:4412; number_of_response:1; }","duration":"107.174193ms","start":"2026-07-21T06:45:00.468479Z","end":"2026-07-21T06:45:00.575653Z","steps":["trace[1265817072] 'process raft request' (duration: 106.553077ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T06:45:10.368376Z","caller":"traceutil/trace.go:171","msg":"trace[1349062976] linearizableReadLoop","detail":"{readStateIndex:4877; appliedIndex:4876; }","duration":"120.051237ms","start":"2026-07-21T06:45:10.248304Z","end":"2026-07-21T06:45:10.368356Z","steps":["trace[1349062976] 'read index received' (duration: 119.81357ms)","trace[1349062976] 'applied index is now lower than readState.Index' (duration: 236.617µs)"],"step_count":2} {"level":"info","ts":"2026-07-21T06:45:10.368438Z","caller":"traceutil/trace.go:171","msg":"trace[992803914] transaction","detail":"{read_only:false; response_revision:4695; number_of_response:1; }","duration":"122.146934ms","start":"2026-07-21T06:45:10.24626Z","end":"2026-07-21T06:45:10.368407Z","steps":["trace[992803914] 'process raft request' (duration: 121.921678ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T06:45:10.368573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.245722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-07-21T06:45:10.368699Z","caller":"traceutil/trace.go:171","msg":"trace[973913279] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:4695; }","duration":"120.406907ms","start":"2026-07-21T06:45:10.248281Z","end":"2026-07-21T06:45:10.368688Z","steps":["trace[973913279] 'agreement among raft nodes before linearized reading' (duration: 120.18647ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T06:45:10.378657Z","caller":"traceutil/trace.go:171","msg":"trace[36496328] transaction","detail":"{read_only:false; response_revision:4696; number_of_response:1; }","duration":"114.760444ms","start":"2026-07-21T06:45:10.263883Z","end":"2026-07-21T06:45:10.378644Z","steps":["trace[36496328] 'process raft request' (duration: 114.545658ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T06:45:10.599663Z","caller":"traceutil/trace.go:171","msg":"trace[879492044] linearizableReadLoop","detail":"{readStateIndex:4879; appliedIndex:4877; }","duration":"223.050771ms","start":"2026-07-21T06:45:10.376528Z","end":"2026-07-21T06:45:10.599579Z","steps":["trace[879492044] 'read index received' (duration: 1.859251ms)","trace[879492044] 'applied index is now lower than readState.Index' (duration: 221.18881ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T06:45:10.59972Z","caller":"traceutil/trace.go:171","msg":"trace[305840451] transaction","detail":"{read_only:false; response_revision:4697; number_of_response:1; }","duration":"226.487404ms","start":"2026-07-21T06:45:10.373203Z","end":"2026-07-21T06:45:10.59969Z","steps":["trace[305840451] 'process raft request' (duration: 204.110665ms)","trace[305840451] 'compare' (duration: 22.002159ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T06:45:10.600193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.4177ms","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-07-21T06:45:10.600229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.236433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T06:45:10.600255Z","caller":"traceutil/trace.go:171","msg":"trace[1237296523] 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:4697; }","duration":"148.533543ms","start":"2026-07-21T06:45:10.451706Z","end":"2026-07-21T06:45:10.60024Z","steps":["trace[1237296523] 'agreement among raft nodes before linearized reading' (duration: 148.313187ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T06:45:10.600299Z","caller":"traceutil/trace.go:171","msg":"trace[1846244396] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:4697; }","duration":"181.360146ms","start":"2026-07-21T06:45:10.418919Z","end":"2026-07-21T06:45:10.600279Z","steps":["trace[1846244396] 'agreement among raft nodes before linearized reading' (duration: 181.215732ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T06:45:10.600325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.742244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:14497"} {"level":"info","ts":"2026-07-21T06:45:10.600416Z","caller":"traceutil/trace.go:171","msg":"trace[620920611] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4697; }","duration":"221.857378ms","start":"2026-07-21T06:45:10.378538Z","end":"2026-07-21T06:45:10.600395Z","steps":["trace[620920611] 'agreement among raft nodes before linearized reading' (duration: 221.456147ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T06:45:10.600807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.265764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"info","ts":"2026-07-21T06:45:10.601599Z","caller":"traceutil/trace.go:171","msg":"trace[1430816202] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4697; }","duration":"225.064007ms","start":"2026-07-21T06:45:10.376504Z","end":"2026-07-21T06:45:10.601568Z","steps":["trace[1430816202] 'agreement among raft nodes before linearized reading' (duration: 223.287138ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T06:45:29.976995Z","caller":"traceutil/trace.go:171","msg":"trace[168271054] linearizableReadLoop","detail":"{readStateIndex:5178; appliedIndex:5177; }","duration":"102.557699ms","start":"2026-07-21T06:45:29.874418Z","end":"2026-07-21T06:45:29.976976Z","steps":["trace[168271054] 'read index received' (duration: 102.361764ms)","trace[168271054] 'applied index is now lower than readState.Index' (duration: 194.975µs)"],"step_count":2} {"level":"info","ts":"2026-07-21T06:45:29.977085Z","caller":"traceutil/trace.go:171","msg":"trace[523322521] transaction","detail":"{read_only:false; response_revision:4988; number_of_response:1; }","duration":"238.763786ms","start":"2026-07-21T06:45:29.738313Z","end":"2026-07-21T06:45:29.977077Z","steps":["trace[523322521] 'process raft request' (duration: 238.524379ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T06:45:29.977236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.800045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-21T06:45:29.977269Z","caller":"traceutil/trace.go:171","msg":"trace[1209553777] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:4988; }","duration":"102.877147ms","start":"2026-07-21T06:45:29.874383Z","end":"2026-07-21T06:45:29.97726Z","steps":["trace[1209553777] 'agreement among raft nodes before linearized reading' (duration: 102.787285ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T06:45:30.602406Z","caller":"traceutil/trace.go:171","msg":"trace[288169994] transaction","detail":"{read_only:false; response_revision:4997; number_of_response:1; }","duration":"118.33198ms","start":"2026-07-21T06:45:30.484057Z","end":"2026-07-21T06:45:30.602389Z","steps":["trace[288169994] 'process raft request' (duration: 117.894178ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T06:45:30.602584Z","caller":"traceutil/trace.go:171","msg":"trace[1891177276] transaction","detail":"{read_only:false; response_revision:4999; number_of_response:1; }","duration":"100.099182ms","start":"2026-07-21T06:45:30.502462Z","end":"2026-07-21T06:45:30.602562Z","steps":["trace[1891177276] 'process raft request' (duration: 99.725141ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T06:45:30.602858Z","caller":"traceutil/trace.go:171","msg":"trace[1297376335] transaction","detail":"{read_only:false; response_revision:4998; number_of_response:1; }","duration":"114.429212ms","start":"2026-07-21T06:45:30.48842Z","end":"2026-07-21T06:45:30.602849Z","steps":["trace[1297376335] 'process raft request' (duration: 113.666282ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T06:46:07.908639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.184374ms","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-07-21T06:46:07.908718Z","caller":"traceutil/trace.go:171","msg":"trace[2113685499] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5332; }","duration":"228.326448ms","start":"2026-07-21T06:46:07.680373Z","end":"2026-07-21T06:46:07.9087Z","steps":["trace[2113685499] 'range keys from in-memory index tree' (duration: 228.008709ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T06:46:07.908739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.375269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-07-21T06:46:07.90881Z","caller":"traceutil/trace.go:171","msg":"trace[88951899] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:5332; }","duration":"228.476762ms","start":"2026-07-21T06:46:07.680316Z","end":"2026-07-21T06:46:07.908793Z","steps":["trace[88951899] 'range keys from in-memory index tree' (duration: 228.256946ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T06:46:08.194545Z","caller":"traceutil/trace.go:171","msg":"trace[1046268014] transaction","detail":"{read_only:false; response_revision:5334; number_of_response:1; }","duration":"218.492709ms","start":"2026-07-21T06:46:07.976015Z","end":"2026-07-21T06:46:08.194508Z","steps":["trace[1046268014] 'process raft request' (duration: 119.106715ms)","trace[1046268014] 'compare' (duration: 99.160778ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T06:46:35.474902Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2887} {"level":"info","ts":"2026-07-21T06:46:35.557629Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2887,"took":"81.622653ms","hash":39420942,"current-db-size-bytes":52736000,"current-db-size":"53 MB","current-db-size-in-use-bytes":29233152,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-21T06:46:35.557704Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":39420942,"revision":2887,"compact-revision":-1} {"level":"info","ts":"2026-07-21T06:51:35.480873Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5555} {"level":"info","ts":"2026-07-21T06:51:35.558457Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5555,"took":"75.859728ms","hash":3440415795,"current-db-size-bytes":52736000,"current-db-size":"53 MB","current-db-size-in-use-bytes":18575360,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-07-21T06:51:35.558524Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3440415795,"revision":5555,"compact-revision":2887}