{"level":"warn","ts":"2026-04-20T11:55:28.870814Z","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-20T11:55:28.870892Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.30: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.30:2380","--initial-cluster=instance=https://199.19.213.30:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.30:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.30: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-20T11:55:28.870955Z","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-20T11:55:28.870964Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.30:2380"]} {"level":"info","ts":"2026-04-20T11:55:28.870981Z","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-20T11:55:28.871586Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.30:2379"]} {"level":"info","ts":"2026-04-20T11:55:28.87166Z","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.19.213.30:2380"],"listen-peer-urls":["https://199.19.213.30:2380"],"advertise-client-urls":["https://199.19.213.30:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.30:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.30: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-20T11:55:28.875702Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.832228ms"} {"level":"info","ts":"2026-04-20T11:55:28.882248Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e2b5783e11defe7e","cluster-id":"5210a9231a779bf0"} {"level":"info","ts":"2026-04-20T11:55:28.882356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T11:55:28.882382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e became follower at term 0"} {"level":"info","ts":"2026-04-20T11:55:28.882403Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e2b5783e11defe7e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T11:55:28.882426Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e became follower at term 1"} {"level":"info","ts":"2026-04-20T11:55:28.882477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e switched to configuration voters=(16336095431339474558)"} {"level":"warn","ts":"2026-04-20T11:55:28.895063Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T11:55:28.89631Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T11:55:28.897345Z","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-20T11:55:28.899326Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e2b5783e11defe7e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T11:55:28.899444Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e2b5783e11defe7e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T11:55:28.899614Z","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-20T11:55:28.899672Z","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-20T11:55:28.899683Z","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-20T11:55:28.900777Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e switched to configuration voters=(16336095431339474558)"} {"level":"info","ts":"2026-04-20T11:55:28.900972Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5210a9231a779bf0","local-member-id":"e2b5783e11defe7e","added-peer-id":"e2b5783e11defe7e","added-peer-peer-urls":["https://199.19.213.30:2380"]} {"level":"info","ts":"2026-04-20T11:55:28.905011Z","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-20T11:55:28.905188Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.30:2380"} {"level":"info","ts":"2026-04-20T11:55:28.90529Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.30:2380"} {"level":"info","ts":"2026-04-20T11:55:28.905337Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e2b5783e11defe7e","initial-advertise-peer-urls":["https://199.19.213.30:2380"],"listen-peer-urls":["https://199.19.213.30:2380"],"advertise-client-urls":["https://199.19.213.30:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.30:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T11:55:28.9054Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T11:55:28.983329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T11:55:28.983392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T11:55:28.98341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e received MsgPreVoteResp from e2b5783e11defe7e at term 1"} {"level":"info","ts":"2026-04-20T11:55:28.983425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e became candidate at term 2"} {"level":"info","ts":"2026-04-20T11:55:28.983433Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e received MsgVoteResp from e2b5783e11defe7e at term 2"} {"level":"info","ts":"2026-04-20T11:55:28.983444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e became leader at term 2"} {"level":"info","ts":"2026-04-20T11:55:28.983452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e2b5783e11defe7e elected leader e2b5783e11defe7e at term 2"} {"level":"info","ts":"2026-04-20T11:55:28.984747Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T11:55:28.985658Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e2b5783e11defe7e","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.30:2379]}","request-path":"/0/members/e2b5783e11defe7e/attributes","cluster-id":"5210a9231a779bf0","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T11:55:28.985685Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T11:55:28.985743Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T11:55:28.986052Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5210a9231a779bf0","local-member-id":"e2b5783e11defe7e","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T11:55:28.986061Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T11:55:28.98613Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T11:55:28.986149Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T11:55:28.986181Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T11:55:28.989198Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T11:55:28.989215Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.30:2379"} {"level":"info","ts":"2026-04-20T11:55:35.246046Z","caller":"traceutil/trace.go:171","msg":"trace[589468470] transaction","detail":"{read_only:false; response_revision:237; number_of_response:1; }","duration":"379.349101ms","start":"2026-04-20T11:55:34.866661Z","end":"2026-04-20T11:55:35.24601Z","steps":["trace[589468470] 'process raft request' (duration: 298.017342ms)","trace[589468470] 'compare' (duration: 81.098473ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:55:35.24703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:34.866627Z","time spent":"379.539435ms","remote":"127.0.0.1:47380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":638,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T11:55:35.247738Z","caller":"traceutil/trace.go:171","msg":"trace[1669304990] linearizableReadLoop","detail":"{readStateIndex:247; appliedIndex:244; }","duration":"237.300804ms","start":"2026-04-20T11:55:35.010368Z","end":"2026-04-20T11:55:35.247669Z","steps":["trace[1669304990] 'read index received' (duration: 154.440231ms)","trace[1669304990] 'applied index is now lower than readState.Index' (duration: 82.859423ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:55:35.248413Z","caller":"traceutil/trace.go:171","msg":"trace[1186192604] transaction","detail":"{read_only:false; response_revision:239; number_of_response:1; }","duration":"370.822644ms","start":"2026-04-20T11:55:34.877433Z","end":"2026-04-20T11:55:35.248255Z","steps":["trace[1186192604] 'process raft request' (duration: 370.151559ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:55:35.248487Z","caller":"traceutil/trace.go:171","msg":"trace[1256752584] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"379.433261ms","start":"2026-04-20T11:55:34.86895Z","end":"2026-04-20T11:55:35.248383Z","steps":["trace[1256752584] 'process raft request' (duration: 378.422629ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:55:35.248786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:34.868936Z","time spent":"379.7253ms","remote":"127.0.0.1:47404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1933,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T11:55:35.248948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.009076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T11:55:35.248948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.42562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:55:35.249126Z","caller":"traceutil/trace.go:171","msg":"trace[72717603] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:239; }","duration":"107.224161ms","start":"2026-04-20T11:55:35.141867Z","end":"2026-04-20T11:55:35.249091Z","steps":["trace[72717603] 'agreement among raft nodes before linearized reading' (duration: 106.095895ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:55:35.24919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:55:34.877401Z","time spent":"371.109021ms","remote":"127.0.0.1:47470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4186,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:55:35.249221Z","caller":"traceutil/trace.go:171","msg":"trace[53753824] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:239; }","duration":"238.797858ms","start":"2026-04-20T11:55:35.010327Z","end":"2026-04-20T11:55:35.249125Z","steps":["trace[53753824] 'agreement among raft nodes before linearized reading' (duration: 237.628011ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:55:42.347468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.327898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-20T11:55:42.347581Z","caller":"traceutil/trace.go:171","msg":"trace[184802750] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:359; }","duration":"112.492382ms","start":"2026-04-20T11:55:42.235065Z","end":"2026-04-20T11:55:42.347557Z","steps":["trace[184802750] 'range keys from in-memory index tree' (duration: 112.213366ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:55:42.61966Z","caller":"traceutil/trace.go:171","msg":"trace[828575284] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"267.826321ms","start":"2026-04-20T11:55:42.351808Z","end":"2026-04-20T11:55:42.619635Z","steps":["trace[828575284] 'process raft request' (duration: 267.672318ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:55:43.031939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.862219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.30\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-20T11:55:43.032027Z","caller":"traceutil/trace.go:171","msg":"trace[946960825] range","detail":"{range_begin:/registry/masterleases/199.19.213.30; range_end:; response_count:1; response_revision:360; }","duration":"211.002772ms","start":"2026-04-20T11:55:42.821004Z","end":"2026-04-20T11:55:43.032007Z","steps":["trace[946960825] 'range keys from in-memory index tree' (duration: 210.706355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:01.226298Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18338268089371522587,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-20T11:56:01.280611Z","caller":"traceutil/trace.go:171","msg":"trace[191432321] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"603.60828ms","start":"2026-04-20T11:56:00.676973Z","end":"2026-04-20T11:56:01.280581Z","steps":["trace[191432321] 'process raft request' (duration: 603.453627ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:01.280754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:00.676952Z","time spent":"603.744263ms","remote":"127.0.0.1:47356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T11:56:01.399821Z","caller":"traceutil/trace.go:171","msg":"trace[430738786] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"721.340962ms","start":"2026-04-20T11:56:00.67841Z","end":"2026-04-20T11:56:01.399751Z","steps":["trace[430738786] 'process raft request' (duration: 721.126547ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:56:01.399892Z","caller":"traceutil/trace.go:171","msg":"trace[437829855] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"720.514844ms","start":"2026-04-20T11:56:00.67932Z","end":"2026-04-20T11:56:01.399835Z","steps":["trace[437829855] 'process raft request' (duration: 720.33219ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:01.399982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:00.678389Z","time spent":"721.518557ms","remote":"127.0.0.1:47356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T11:56:01.400056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:00.679303Z","time spent":"720.671507ms","remote":"127.0.0.1:47356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T11:56:01.40004Z","caller":"traceutil/trace.go:171","msg":"trace[1590505455] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"706.563105ms","start":"2026-04-20T11:56:00.69342Z","end":"2026-04-20T11:56:01.399983Z","steps":["trace[1590505455] 'process raft request' (duration: 706.3167ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:56:01.400133Z","caller":"traceutil/trace.go:171","msg":"trace[845855716] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"710.008103ms","start":"2026-04-20T11:56:00.690074Z","end":"2026-04-20T11:56:01.400082Z","steps":["trace[845855716] 'process raft request' (duration: 709.624665ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:56:01.400161Z","caller":"traceutil/trace.go:171","msg":"trace[1247104323] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"699.911953ms","start":"2026-04-20T11:56:00.700219Z","end":"2026-04-20T11:56:01.400131Z","steps":["trace[1247104323] 'process raft request' (duration: 699.589585ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:56:01.400173Z","caller":"traceutil/trace.go:171","msg":"trace[1264931456] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"699.762529ms","start":"2026-04-20T11:56:00.700355Z","end":"2026-04-20T11:56:01.400118Z","steps":["trace[1264931456] 'process raft request' (duration: 699.538094ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:56:01.400218Z","caller":"traceutil/trace.go:171","msg":"trace[532227989] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"699.882711ms","start":"2026-04-20T11:56:00.700275Z","end":"2026-04-20T11:56:01.400157Z","steps":["trace[532227989] 'process raft request' (duration: 699.577294ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:56:01.400239Z","caller":"traceutil/trace.go:171","msg":"trace[1718187638] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"690.143599ms","start":"2026-04-20T11:56:00.710079Z","end":"2026-04-20T11:56:01.400222Z","steps":["trace[1718187638] 'process raft request' (duration: 689.869802ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:01.400243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:00.693404Z","time spent":"706.741889ms","remote":"127.0.0.1:47356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T11:56:01.400269Z","caller":"traceutil/trace.go:171","msg":"trace[1088357924] linearizableReadLoop","detail":"{readStateIndex:500; appliedIndex:488; }","duration":"674.00887ms","start":"2026-04-20T11:56:00.726241Z","end":"2026-04-20T11:56:01.40025Z","steps":["trace[1088357924] 'read index received' (duration: 554.18005ms)","trace[1088357924] 'applied index is now lower than readState.Index' (duration: 119.82788ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:56:01.400292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:00.700207Z","time spent":"700.024635ms","remote":"127.0.0.1:47356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T11:56:01.400321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:00.710066Z","time spent":"690.219761ms","remote":"127.0.0.1:47356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T11:56:01.400315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:00.690054Z","time spent":"710.175597ms","remote":"127.0.0.1:47356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T11:56:01.400338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:00.70027Z","time spent":"700.011954ms","remote":"127.0.0.1:47356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T11:56:01.400377Z","caller":"traceutil/trace.go:171","msg":"trace[1530935101] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"668.290099ms","start":"2026-04-20T11:56:00.73208Z","end":"2026-04-20T11:56:01.40037Z","steps":["trace[1530935101] 'process raft request' (duration: 667.971902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:01.400326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:00.700348Z","time spent":"699.903902ms","remote":"127.0.0.1:47356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T11:56:01.400347Z","caller":"traceutil/trace.go:171","msg":"trace[1284415437] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"680.421586ms","start":"2026-04-20T11:56:00.719914Z","end":"2026-04-20T11:56:01.400336Z","steps":["trace[1284415437] 'process raft request' (duration: 680.085479ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:56:01.400418Z","caller":"traceutil/trace.go:171","msg":"trace[1137598817] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"562.080671ms","start":"2026-04-20T11:56:00.838322Z","end":"2026-04-20T11:56:01.400403Z","steps":["trace[1137598817] 'process raft request' (duration: 561.798744ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:01.40045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:00.732057Z","time spent":"668.351891ms","remote":"127.0.0.1:47356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T11:56:01.400463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:00.719901Z","time spent":"680.540359ms","remote":"127.0.0.1:47356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T11:56:01.400475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:00.838289Z","time spent":"562.160423ms","remote":"127.0.0.1:47356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T11:56:01.400578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.336087ms","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-20T11:56:01.400643Z","caller":"traceutil/trace.go:171","msg":"trace[681943221] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:480; }","duration":"674.43146ms","start":"2026-04-20T11:56:00.726195Z","end":"2026-04-20T11:56:01.400627Z","steps":["trace[681943221] 'agreement among raft nodes before linearized reading' (duration: 674.214715ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:01.400685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:00.726176Z","time spent":"674.499241ms","remote":"127.0.0.1:47568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-20T11:56:01.41677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.930389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:56:01.416862Z","caller":"traceutil/trace.go:171","msg":"trace[1051810342] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:482; }","duration":"374.067963ms","start":"2026-04-20T11:56:01.042775Z","end":"2026-04-20T11:56:01.416843Z","steps":["trace[1051810342] 'agreement among raft nodes before linearized reading' (duration: 373.928749ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:56:01.416888Z","caller":"traceutil/trace.go:171","msg":"trace[1917883128] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"129.89857ms","start":"2026-04-20T11:56:01.286967Z","end":"2026-04-20T11:56:01.416866Z","steps":["trace[1917883128] 'process raft request' (duration: 129.595063ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:56:01.416883Z","caller":"traceutil/trace.go:171","msg":"trace[269561935] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"128.14837ms","start":"2026-04-20T11:56:01.288706Z","end":"2026-04-20T11:56:01.416855Z","steps":["trace[269561935] 'process raft request' (duration: 127.942215ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:01.416896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:01.042755Z","time spent":"374.132634ms","remote":"127.0.0.1:47318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-20T11:56:01.828525Z","caller":"traceutil/trace.go:171","msg":"trace[573780536] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"170.022227ms","start":"2026-04-20T11:56:01.658476Z","end":"2026-04-20T11:56:01.828498Z","steps":["trace[573780536] 'process raft request' (duration: 169.961056ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:56:01.828586Z","caller":"traceutil/trace.go:171","msg":"trace[1225373006] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"172.693659ms","start":"2026-04-20T11:56:01.655834Z","end":"2026-04-20T11:56:01.828528Z","steps":["trace[1225373006] 'process raft request' (duration: 86.748343ms)","trace[1225373006] 'compare' (duration: 85.67122ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:56:01.831739Z","caller":"traceutil/trace.go:171","msg":"trace[1590433397] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"156.014037ms","start":"2026-04-20T11:56:01.675712Z","end":"2026-04-20T11:56:01.831726Z","steps":["trace[1590433397] 'process raft request' (duration: 155.919305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:06.082153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.846834ms","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-20T11:56:06.082361Z","caller":"traceutil/trace.go:171","msg":"trace[942167782] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:565; }","duration":"104.07271ms","start":"2026-04-20T11:56:05.978263Z","end":"2026-04-20T11:56:06.082335Z","steps":["trace[942167782] 'range keys from in-memory index tree' (duration: 103.830233ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:06.082165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.418507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-20T11:56:06.082508Z","caller":"traceutil/trace.go:171","msg":"trace[199795463] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:565; }","duration":"170.789185ms","start":"2026-04-20T11:56:05.911679Z","end":"2026-04-20T11:56:06.082468Z","steps":["trace[199795463] 'range keys from in-memory index tree' (duration: 170.334125ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:56:07.983831Z","caller":"traceutil/trace.go:171","msg":"trace[1595211004] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"169.849374ms","start":"2026-04-20T11:56:07.813954Z","end":"2026-04-20T11:56:07.983804Z","steps":["trace[1595211004] 'process raft request' (duration: 169.66377ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:08.228382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.951279ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-04-20T11:56:09.030503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.843448ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T11:56:09.030613Z","caller":"traceutil/trace.go:171","msg":"trace[1907021340] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"735.762662ms","start":"2026-04-20T11:56:08.29483Z","end":"2026-04-20T11:56:09.030593Z","steps":["trace[1907021340] 'process raft request' (duration: 469.776161ms)","trace[1907021340] 'compare' (duration: 265.720904ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:56:09.030668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:08.294792Z","time spent":"735.851904ms","remote":"127.0.0.1:47546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T11:56:14.968271Z","caller":"traceutil/trace.go:171","msg":"trace[214240653] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"103.565288ms","start":"2026-04-20T11:56:14.864661Z","end":"2026-04-20T11:56:14.968227Z","steps":["trace[214240653] 'process raft request' (duration: 93.655862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:32.103742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.26393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-20T11:56:32.103863Z","caller":"traceutil/trace.go:171","msg":"trace[1455594075] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:763; }","duration":"452.431464ms","start":"2026-04-20T11:56:31.65141Z","end":"2026-04-20T11:56:32.103841Z","steps":["trace[1455594075] 'range keys from in-memory index tree' (duration: 452.079895ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:32.103917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:31.651389Z","time spent":"452.515246ms","remote":"127.0.0.1:47568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T11:56:32.10394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"726.173472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T11:56:32.104011Z","caller":"traceutil/trace.go:171","msg":"trace[1436435904] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:763; }","duration":"726.315635ms","start":"2026-04-20T11:56:31.377678Z","end":"2026-04-20T11:56:32.103994Z","steps":["trace[1436435904] 'count revisions from in-memory index tree' (duration: 726.08357ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:32.104043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:31.377657Z","time spent":"726.377587ms","remote":"127.0.0.1:47752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":3,"response size":30,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-04-20T11:56:32.104049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.383845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-20T11:56:32.104131Z","caller":"traceutil/trace.go:171","msg":"trace[2135836228] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:763; }","duration":"460.510218ms","start":"2026-04-20T11:56:31.643599Z","end":"2026-04-20T11:56:32.104109Z","steps":["trace[2135836228] 'range keys from in-memory index tree' (duration: 460.170141ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:32.104169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:31.643579Z","time spent":"460.582549ms","remote":"127.0.0.1:47568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-20T11:56:32.104187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.901704ms","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-20T11:56:32.10429Z","caller":"traceutil/trace.go:171","msg":"trace[645388696] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:763; }","duration":"453.048208ms","start":"2026-04-20T11:56:31.65122Z","end":"2026-04-20T11:56:32.104268Z","steps":["trace[645388696] 'range keys from in-memory index tree' (duration: 452.69954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:56:32.104296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.595005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T11:56:32.104342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:56:31.6512Z","time spent":"453.13093ms","remote":"127.0.0.1:47568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-20T11:56:32.104401Z","caller":"traceutil/trace.go:171","msg":"trace[1259882866] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:763; }","duration":"252.710877ms","start":"2026-04-20T11:56:31.851626Z","end":"2026-04-20T11:56:32.104336Z","steps":["trace[1259882866] 'count revisions from in-memory index tree' (duration: 252.527133ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:56:32.150213Z","caller":"traceutil/trace.go:171","msg":"trace[300051320] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"219.611691ms","start":"2026-04-20T11:56:31.930574Z","end":"2026-04-20T11:56:32.150186Z","steps":["trace[300051320] 'process raft request' (duration: 219.411506ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:16.520317Z","caller":"traceutil/trace.go:171","msg":"trace[666904730] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"107.177569ms","start":"2026-04-20T11:57:16.413111Z","end":"2026-04-20T11:57:16.520288Z","steps":["trace[666904730] 'process raft request' (duration: 106.990735ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:16.546032Z","caller":"traceutil/trace.go:171","msg":"trace[510157542] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"132.299055ms","start":"2026-04-20T11:57:16.413711Z","end":"2026-04-20T11:57:16.54601Z","steps":["trace[510157542] 'process raft request' (duration: 132.152172ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:16.546317Z","caller":"traceutil/trace.go:171","msg":"trace[1584817854] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"131.952617ms","start":"2026-04-20T11:57:16.414289Z","end":"2026-04-20T11:57:16.546241Z","steps":["trace[1584817854] 'process raft request' (duration: 131.673931ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:23.469357Z","caller":"traceutil/trace.go:171","msg":"trace[1280139480] transaction","detail":"{read_only:false; response_revision:1425; number_of_response:1; }","duration":"273.23887ms","start":"2026-04-20T11:57:23.196089Z","end":"2026-04-20T11:57:23.469328Z","steps":["trace[1280139480] 'process raft request' (duration: 273.082497ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:47.420222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.372921ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T11:57:47.420332Z","caller":"traceutil/trace.go:171","msg":"trace[2084220138] linearizableReadLoop","detail":"{readStateIndex:1910; appliedIndex:1909; }","duration":"364.672378ms","start":"2026-04-20T11:57:47.055643Z","end":"2026-04-20T11:57:47.420315Z","steps":["trace[2084220138] 'read index received' (duration: 241.075291ms)","trace[2084220138] 'applied index is now lower than readState.Index' (duration: 123.595747ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:57:47.42037Z","caller":"traceutil/trace.go:171","msg":"trace[2104082500] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"428.750809ms","start":"2026-04-20T11:57:46.991588Z","end":"2026-04-20T11:57:47.420339Z","steps":["trace[2104082500] 'process raft request' (duration: 305.155932ms)","trace[2104082500] 'compare' (duration: 123.233938ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:57:47.420477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.845273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-20T11:57:47.420499Z","caller":"traceutil/trace.go:171","msg":"trace[2065097432] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1834; }","duration":"364.895193ms","start":"2026-04-20T11:57:47.055595Z","end":"2026-04-20T11:57:47.42049Z","steps":["trace[2065097432] 'agreement among raft nodes before linearized reading' (duration: 364.77839ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:47.420508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:57:46.991564Z","time spent":"428.861542ms","remote":"127.0.0.1:47568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T11:57:47.420524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:57:47.055573Z","time spent":"364.945125ms","remote":"127.0.0.1:47568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-20T11:57:47.451156Z","caller":"traceutil/trace.go:171","msg":"trace[2060762911] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"309.074232ms","start":"2026-04-20T11:57:47.142021Z","end":"2026-04-20T11:57:47.451096Z","steps":["trace[2060762911] 'process raft request' (duration: 308.794565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:47.451181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.962665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a4d5292d-f737-47a6-96ad-948b795c0d1a\" ","response":"range_response_count:1 size:3626"} {"level":"warn","ts":"2026-04-20T11:57:47.451447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:57:47.141992Z","time spent":"309.320118ms","remote":"127.0.0.1:47568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:57:47.451498Z","caller":"traceutil/trace.go:171","msg":"trace[1664576878] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a4d5292d-f737-47a6-96ad-948b795c0d1a; range_end:; response_count:1; response_revision:1835; }","duration":"182.330314ms","start":"2026-04-20T11:57:47.269133Z","end":"2026-04-20T11:57:47.451463Z","steps":["trace[1664576878] 'agreement among raft nodes before linearized reading' (duration: 181.852962ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:47.589695Z","caller":"traceutil/trace.go:171","msg":"trace[55977804] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"129.502162ms","start":"2026-04-20T11:57:47.460159Z","end":"2026-04-20T11:57:47.589661Z","steps":["trace[55977804] 'process raft request' (duration: 109.37858ms)","trace[55977804] 'compare' (duration: 19.999519ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:57:47.981766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.811371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-20T11:57:47.981885Z","caller":"traceutil/trace.go:171","msg":"trace[1662141418] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1837; }","duration":"201.988305ms","start":"2026-04-20T11:57:47.77987Z","end":"2026-04-20T11:57:47.981859Z","steps":["trace[1662141418] 'range keys from in-memory index tree' (duration: 201.604706ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:58:01.752098Z","caller":"traceutil/trace.go:171","msg":"trace[1347476487] linearizableReadLoop","detail":"{readStateIndex:2031; appliedIndex:2030; }","duration":"205.64483ms","start":"2026-04-20T11:58:01.546429Z","end":"2026-04-20T11:58:01.752073Z","steps":["trace[1347476487] 'read index received' (duration: 205.428634ms)","trace[1347476487] 'applied index is now lower than readState.Index' (duration: 215.346µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:58:01.752171Z","caller":"traceutil/trace.go:171","msg":"trace[829413976] transaction","detail":"{read_only:false; response_revision:1952; number_of_response:1; }","duration":"258.679576ms","start":"2026-04-20T11:58:01.493459Z","end":"2026-04-20T11:58:01.752138Z","steps":["trace[829413976] 'process raft request' (duration: 258.44932ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:58:01.752339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.898255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-20T11:58:01.752381Z","caller":"traceutil/trace.go:171","msg":"trace[62652847] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1952; }","duration":"205.997047ms","start":"2026-04-20T11:58:01.546374Z","end":"2026-04-20T11:58:01.752371Z","steps":["trace[62652847] 'agreement among raft nodes before linearized reading' (duration: 205.810653ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:58:32.073496Z","caller":"traceutil/trace.go:171","msg":"trace[7350708] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"139.986181ms","start":"2026-04-20T11:58:31.933446Z","end":"2026-04-20T11:58:32.073432Z","steps":["trace[7350708] 'process raft request' (duration: 122.639375ms)","trace[7350708] 'compare' (duration: 16.651601ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:58:38.29297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.760631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:58:38.293173Z","caller":"traceutil/trace.go:171","msg":"trace[1614612438] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2165; }","duration":"250.020067ms","start":"2026-04-20T11:58:38.043122Z","end":"2026-04-20T11:58:38.293142Z","steps":["trace[1614612438] 'range keys from in-memory index tree' (duration: 249.648508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:58:38.293918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.404248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-20T11:58:38.294073Z","caller":"traceutil/trace.go:171","msg":"trace[454364664] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2165; }","duration":"195.560912ms","start":"2026-04-20T11:58:38.098459Z","end":"2026-04-20T11:58:38.29402Z","steps":["trace[454364664] 'range keys from in-memory index tree' (duration: 194.122128ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:58:38.307826Z","caller":"traceutil/trace.go:171","msg":"trace[1951619721] transaction","detail":"{read_only:false; response_revision:2166; number_of_response:1; }","duration":"105.145815ms","start":"2026-04-20T11:58:38.202649Z","end":"2026-04-20T11:58:38.307795Z","steps":["trace[1951619721] 'process raft request' (duration: 104.880359ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:58:38.895852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.432543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-04-20T11:58:38.895933Z","caller":"traceutil/trace.go:171","msg":"trace[1381587109] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2168; }","duration":"378.622626ms","start":"2026-04-20T11:58:38.517287Z","end":"2026-04-20T11:58:38.89591Z","steps":["trace[1381587109] 'range keys from in-memory index tree' (duration: 378.290689ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:58:38.895969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:58:38.517275Z","time spent":"378.685178ms","remote":"127.0.0.1:47568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-04-20T11:58:38.896026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.312759ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T11:58:38.896122Z","caller":"traceutil/trace.go:171","msg":"trace[673051390] linearizableReadLoop","detail":"{readStateIndex:2256; appliedIndex:2255; }","duration":"284.025565ms","start":"2026-04-20T11:58:38.612084Z","end":"2026-04-20T11:58:38.89611Z","steps":["trace[673051390] 'read index received' (duration: 52.442199ms)","trace[673051390] 'applied index is now lower than readState.Index' (duration: 231.582046ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:58:38.896194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.105016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T11:58:38.896214Z","caller":"traceutil/trace.go:171","msg":"trace[1813445428] transaction","detail":"{read_only:false; response_revision:2169; number_of_response:1; }","duration":"320.256612ms","start":"2026-04-20T11:58:38.575879Z","end":"2026-04-20T11:58:38.896135Z","steps":["trace[1813445428] 'process raft request' (duration: 88.709248ms)","trace[1813445428] 'compare' (duration: 230.974271ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:58:38.896457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:58:38.575852Z","time spent":"320.489878ms","remote":"127.0.0.1:47568","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-20T11:58:38.896287Z","caller":"traceutil/trace.go:171","msg":"trace[1794676667] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:2169; }","duration":"284.211388ms","start":"2026-04-20T11:58:38.61205Z","end":"2026-04-20T11:58:38.896261Z","steps":["trace[1794676667] 'agreement among raft nodes before linearized reading' (duration: 284.105136ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:58:39.216929Z","caller":"traceutil/trace.go:171","msg":"trace[1266797358] transaction","detail":"{read_only:false; response_revision:2170; number_of_response:1; }","duration":"364.600357ms","start":"2026-04-20T11:58:38.852277Z","end":"2026-04-20T11:58:39.216877Z","steps":["trace[1266797358] 'process raft request' (duration: 364.372951ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:58:39.217151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:58:38.852256Z","time spent":"364.77566ms","remote":"127.0.0.1:47470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8542,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:58:39.217991Z","caller":"traceutil/trace.go:171","msg":"trace[1339322654] transaction","detail":"{read_only:false; response_revision:2171; number_of_response:1; }","duration":"317.740906ms","start":"2026-04-20T11:58:38.900215Z","end":"2026-04-20T11:58:39.217956Z","steps":["trace[1339322654] 'process raft request' (duration: 317.48191ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:58:39.218301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:58:38.900192Z","time spent":"317.96666ms","remote":"127.0.0.1:47568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:58:39.218379Z","caller":"traceutil/trace.go:171","msg":"trace[705341200] linearizableReadLoop","detail":"{readStateIndex:2259; appliedIndex:2256; }","duration":"248.215195ms","start":"2026-04-20T11:58:38.970115Z","end":"2026-04-20T11:58:39.218331Z","steps":["trace[705341200] 'read index received' (duration: 246.506026ms)","trace[705341200] 'applied index is now lower than readState.Index' (duration: 1.707889ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:58:39.218724Z","caller":"traceutil/trace.go:171","msg":"trace[1429547773] transaction","detail":"{read_only:false; response_revision:2172; number_of_response:1; }","duration":"283.83332ms","start":"2026-04-20T11:58:38.934874Z","end":"2026-04-20T11:58:39.218708Z","steps":["trace[1429547773] 'process raft request' (duration: 283.021482ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:58:39.218999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.871196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-20T11:58:39.218994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.842391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:58:39.219064Z","caller":"traceutil/trace.go:171","msg":"trace[1640523976] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2172; }","duration":"243.994758ms","start":"2026-04-20T11:58:38.975053Z","end":"2026-04-20T11:58:39.219047Z","steps":["trace[1640523976] 'agreement among raft nodes before linearized reading' (duration: 243.769033ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:58:39.219097Z","caller":"traceutil/trace.go:171","msg":"trace[1785816602] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2172; }","duration":"175.964674ms","start":"2026-04-20T11:58:39.043094Z","end":"2026-04-20T11:58:39.219058Z","steps":["trace[1785816602] 'agreement among raft nodes before linearized reading' (duration: 175.822621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:58:39.219263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.128897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-20T11:58:39.219327Z","caller":"traceutil/trace.go:171","msg":"trace[185435947] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2172; }","duration":"249.249139ms","start":"2026-04-20T11:58:38.970059Z","end":"2026-04-20T11:58:39.219309Z","steps":["trace[185435947] 'agreement among raft nodes before linearized reading' (duration: 249.017774ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:58:39.219698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.404428ms","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-20T11:58:39.219843Z","caller":"traceutil/trace.go:171","msg":"trace[486233355] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2172; }","duration":"244.579452ms","start":"2026-04-20T11:58:38.975244Z","end":"2026-04-20T11:58:39.219823Z","steps":["trace[486233355] 'agreement among raft nodes before linearized reading' (duration: 244.238064ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:58:44.67735Z","caller":"traceutil/trace.go:171","msg":"trace[2137485360] transaction","detail":"{read_only:false; response_revision:2200; number_of_response:1; }","duration":"180.365733ms","start":"2026-04-20T11:58:44.496955Z","end":"2026-04-20T11:58:44.67732Z","steps":["trace[2137485360] 'process raft request' (duration: 172.039103ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:00:08.519228Z","caller":"traceutil/trace.go:171","msg":"trace[351146797] transaction","detail":"{read_only:false; response_revision:2847; number_of_response:1; }","duration":"179.172736ms","start":"2026-04-20T12:00:08.340027Z","end":"2026-04-20T12:00:08.5192Z","steps":["trace[351146797] 'process raft request' (duration: 179.010293ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:00:09.267403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.423021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-20T12:00:09.267466Z","caller":"traceutil/trace.go:171","msg":"trace[916528779] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2848; }","duration":"225.528053ms","start":"2026-04-20T12:00:09.041926Z","end":"2026-04-20T12:00:09.267454Z","steps":["trace[916528779] 'range keys from in-memory index tree' (duration: 225.283588ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:02:40.530466Z","caller":"traceutil/trace.go:171","msg":"trace[1606746939] transaction","detail":"{read_only:false; response_revision:3846; number_of_response:1; }","duration":"411.326125ms","start":"2026-04-20T12:02:40.119019Z","end":"2026-04-20T12:02:40.530345Z","steps":["trace[1606746939] 'process raft request' (duration: 411.10966ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:02:40.530702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:02:40.119002Z","time spent":"411.578571ms","remote":"127.0.0.1:47568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T12:02:40.534981Z","caller":"traceutil/trace.go:171","msg":"trace[1466183772] linearizableReadLoop","detail":"{readStateIndex:3997; appliedIndex:3995; }","duration":"131.414713ms","start":"2026-04-20T12:02:40.403536Z","end":"2026-04-20T12:02:40.53495Z","steps":["trace[1466183772] 'read index received' (duration: 126.595964ms)","trace[1466183772] 'applied index is now lower than readState.Index' (duration: 4.816649ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T12:02:40.535171Z","caller":"traceutil/trace.go:171","msg":"trace[950923499] transaction","detail":"{read_only:false; response_revision:3847; number_of_response:1; }","duration":"413.126106ms","start":"2026-04-20T12:02:40.122009Z","end":"2026-04-20T12:02:40.535135Z","steps":["trace[950923499] 'process raft request' (duration: 412.720717ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:02:40.535283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.72536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-20T12:02:40.535344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:02:40.121986Z","time spent":"413.26072ms","remote":"127.0.0.1:47568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T12:02:40.535356Z","caller":"traceutil/trace.go:171","msg":"trace[229477486] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:3847; }","duration":"131.852643ms","start":"2026-04-20T12:02:40.403485Z","end":"2026-04-20T12:02:40.535338Z","steps":["trace[229477486] 'agreement among raft nodes before linearized reading' (duration: 131.638538ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:03:57.236786Z","caller":"traceutil/trace.go:171","msg":"trace[1865366184] transaction","detail":"{read_only:false; response_revision:4740; number_of_response:1; }","duration":"103.495262ms","start":"2026-04-20T12:03:57.133271Z","end":"2026-04-20T12:03:57.236766Z","steps":["trace[1865366184] 'process raft request' (duration: 103.39262ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:03:57.240772Z","caller":"traceutil/trace.go:171","msg":"trace[1622070740] linearizableReadLoop","detail":"{readStateIndex:4927; appliedIndex:4925; }","duration":"104.441304ms","start":"2026-04-20T12:03:57.136316Z","end":"2026-04-20T12:03:57.240758Z","steps":["trace[1622070740] 'read index received' (duration: 100.343921ms)","trace[1622070740] 'applied index is now lower than readState.Index' (duration: 4.095113ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T12:03:57.240872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.541137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T12:03:57.240902Z","caller":"traceutil/trace.go:171","msg":"trace[1013021731] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:0; response_revision:4741; }","duration":"104.624828ms","start":"2026-04-20T12:03:57.136268Z","end":"2026-04-20T12:03:57.240892Z","steps":["trace[1013021731] 'agreement among raft nodes before linearized reading' (duration: 104.543187ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:03:57.240964Z","caller":"traceutil/trace.go:171","msg":"trace[1828985002] transaction","detail":"{read_only:false; response_revision:4741; number_of_response:1; }","duration":"107.598766ms","start":"2026-04-20T12:03:57.133282Z","end":"2026-04-20T12:03:57.240881Z","steps":["trace[1828985002] 'process raft request' (duration: 107.411242ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:04:02.542041Z","caller":"traceutil/trace.go:171","msg":"trace[346443102] transaction","detail":"{read_only:false; response_revision:4901; number_of_response:1; }","duration":"104.72837ms","start":"2026-04-20T12:04:02.437277Z","end":"2026-04-20T12:04:02.542006Z","steps":["trace[346443102] 'process raft request' (duration: 43.490328ms)","trace[346443102] 'compare' (duration: 60.984896ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T12:04:03.170936Z","caller":"traceutil/trace.go:171","msg":"trace[863529580] linearizableReadLoop","detail":"{readStateIndex:5104; appliedIndex:5103; }","duration":"124.634412ms","start":"2026-04-20T12:04:03.046285Z","end":"2026-04-20T12:04:03.17092Z","steps":["trace[863529580] 'read index received' (duration: 121.768297ms)","trace[863529580] 'applied index is now lower than readState.Index' (duration: 2.865245ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T12:04:03.171012Z","caller":"traceutil/trace.go:171","msg":"trace[2827399] transaction","detail":"{read_only:false; response_revision:4914; number_of_response:1; }","duration":"153.168551ms","start":"2026-04-20T12:04:03.017833Z","end":"2026-04-20T12:04:03.171002Z","steps":["trace[2827399] 'process raft request' (duration: 150.101291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:04:03.171084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.787375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T12:04:03.171135Z","caller":"traceutil/trace.go:171","msg":"trace[1901604544] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4914; }","duration":"124.874838ms","start":"2026-04-20T12:04:03.046248Z","end":"2026-04-20T12:04:03.171123Z","steps":["trace[1901604544] 'agreement among raft nodes before linearized reading' (duration: 124.764515ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:04:05.236716Z","caller":"traceutil/trace.go:171","msg":"trace[1321918123] transaction","detail":"{read_only:false; response_revision:5035; number_of_response:1; }","duration":"126.187648ms","start":"2026-04-20T12:04:05.110503Z","end":"2026-04-20T12:04:05.23669Z","steps":["trace[1321918123] 'process raft request' (duration: 126.005174ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:04:05.4003Z","caller":"traceutil/trace.go:171","msg":"trace[138268234] transaction","detail":"{read_only:false; response_revision:5036; number_of_response:1; }","duration":"161.90098ms","start":"2026-04-20T12:04:05.238362Z","end":"2026-04-20T12:04:05.400263Z","steps":["trace[138268234] 'process raft request' (duration: 148.443644ms)","trace[138268234] 'compare' (duration: 13.343073ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T12:04:05.460757Z","caller":"traceutil/trace.go:171","msg":"trace[2004046335] transaction","detail":"{read_only:false; response_revision:5039; number_of_response:1; }","duration":"127.726123ms","start":"2026-04-20T12:04:05.332992Z","end":"2026-04-20T12:04:05.460719Z","steps":["trace[2004046335] 'process raft request' (duration: 127.362435ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:04:05.460941Z","caller":"traceutil/trace.go:171","msg":"trace[57411631] transaction","detail":"{read_only:false; response_revision:5037; number_of_response:1; }","duration":"220.340058ms","start":"2026-04-20T12:04:05.240523Z","end":"2026-04-20T12:04:05.460863Z","steps":["trace[57411631] 'process raft request' (duration: 219.592851ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:04:05.461301Z","caller":"traceutil/trace.go:171","msg":"trace[258529228] transaction","detail":"{read_only:false; response_revision:5038; number_of_response:1; }","duration":"218.573387ms","start":"2026-04-20T12:04:05.242097Z","end":"2026-04-20T12:04:05.46067Z","steps":["trace[258529228] 'process raft request' (duration: 218.199519ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:04:07.654375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.296031ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T12:04:07.654576Z","caller":"traceutil/trace.go:171","msg":"trace[1654867061] transaction","detail":"{read_only:false; response_revision:5072; number_of_response:1; }","duration":"185.862224ms","start":"2026-04-20T12:04:07.468683Z","end":"2026-04-20T12:04:07.654545Z","steps":["trace[1654867061] 'process raft request' (duration: 66.276236ms)","trace[1654867061] 'compare' (duration: 119.118128ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T12:04:17.183999Z","caller":"traceutil/trace.go:171","msg":"trace[612474936] transaction","detail":"{read_only:false; response_revision:5272; number_of_response:1; }","duration":"155.555056ms","start":"2026-04-20T12:04:17.028419Z","end":"2026-04-20T12:04:17.183975Z","steps":["trace[612474936] 'process raft request' (duration: 155.438914ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:04:17.184043Z","caller":"traceutil/trace.go:171","msg":"trace[2049733675] transaction","detail":"{read_only:false; response_revision:5271; number_of_response:1; }","duration":"155.605287ms","start":"2026-04-20T12:04:17.028388Z","end":"2026-04-20T12:04:17.183993Z","steps":["trace[2049733675] 'process raft request' (duration: 96.40083ms)","trace[2049733675] 'compare' (duration: 58.90646ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T12:04:17.184132Z","caller":"traceutil/trace.go:171","msg":"trace[1039686508] linearizableReadLoop","detail":"{readStateIndex:5473; appliedIndex:5470; }","duration":"143.39518ms","start":"2026-04-20T12:04:17.040713Z","end":"2026-04-20T12:04:17.184108Z","steps":["trace[1039686508] 'read index received' (duration: 84.0241ms)","trace[1039686508] 'applied index is now lower than readState.Index' (duration: 59.36903ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T12:04:17.184184Z","caller":"traceutil/trace.go:171","msg":"trace[123108468] transaction","detail":"{read_only:false; response_revision:5273; number_of_response:1; }","duration":"155.73784ms","start":"2026-04-20T12:04:17.028425Z","end":"2026-04-20T12:04:17.184163Z","steps":["trace[123108468] 'process raft request' (duration: 155.503155ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:04:17.184237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.510953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T12:04:17.184261Z","caller":"traceutil/trace.go:171","msg":"trace[1548270803] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5273; }","duration":"143.567033ms","start":"2026-04-20T12:04:17.040686Z","end":"2026-04-20T12:04:17.184253Z","steps":["trace[1548270803] 'agreement among raft nodes before linearized reading' (duration: 143.499142ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:04:24.624098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.042777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-77d3a0ec-85c6-424b-85f4-df3c83f40684\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-04-20T12:04:24.62418Z","caller":"traceutil/trace.go:171","msg":"trace[76468256] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-77d3a0ec-85c6-424b-85f4-df3c83f40684; range_end:; response_count:1; response_revision:5407; }","duration":"252.184401ms","start":"2026-04-20T12:04:24.371975Z","end":"2026-04-20T12:04:24.624159Z","steps":["trace[76468256] 'range keys from in-memory index tree' (duration: 251.854903ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:04:24.624456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.313214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T12:04:24.624552Z","caller":"traceutil/trace.go:171","msg":"trace[347156563] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1; range_end:; response_count:0; response_revision:5407; }","duration":"252.470468ms","start":"2026-04-20T12:04:24.372061Z","end":"2026-04-20T12:04:24.624532Z","steps":["trace[347156563] 'range keys from in-memory index tree' (duration: 252.213191ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:04:24.624793Z","caller":"traceutil/trace.go:171","msg":"trace[886919932] linearizableReadLoop","detail":"{readStateIndex:5611; appliedIndex:5610; }","duration":"176.615884ms","start":"2026-04-20T12:04:24.448152Z","end":"2026-04-20T12:04:24.624768Z","steps":["trace[886919932] 'read index received' (duration: 85.219276ms)","trace[886919932] 'applied index is now lower than readState.Index' (duration: 91.395408ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T12:04:24.625019Z","caller":"traceutil/trace.go:171","msg":"trace[258860457] transaction","detail":"{read_only:false; response_revision:5408; number_of_response:1; }","duration":"244.873686ms","start":"2026-04-20T12:04:24.380131Z","end":"2026-04-20T12:04:24.625005Z","steps":["trace[258860457] 'process raft request' (duration: 153.228793ms)","trace[258860457] 'compare' (duration: 91.270295ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T12:04:24.625371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.204997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-04-20T12:04:24.625415Z","caller":"traceutil/trace.go:171","msg":"trace[1705656091] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5408; }","duration":"177.262478ms","start":"2026-04-20T12:04:24.448141Z","end":"2026-04-20T12:04:24.625403Z","steps":["trace[1705656091] 'agreement among raft nodes before linearized reading' (duration: 177.091294ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:04:24.625968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.322196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18a80f1b6d935f1c\" ","response":"range_response_count:1 size:1012"} {"level":"warn","ts":"2026-04-20T12:04:24.625663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.134939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-77d3a0ec-85c6-424b-85f4-df3c83f40684\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-04-20T12:04:24.626088Z","caller":"traceutil/trace.go:171","msg":"trace[99177494] range","detail":"{range_begin:/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18a80f1b6d935f1c; range_end:; response_count:1; response_revision:5408; }","duration":"139.555892ms","start":"2026-04-20T12:04:24.486504Z","end":"2026-04-20T12:04:24.62606Z","steps":["trace[99177494] 'agreement among raft nodes before linearized reading' (duration: 138.984969ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:04:24.626133Z","caller":"traceutil/trace.go:171","msg":"trace[361814951] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-77d3a0ec-85c6-424b-85f4-df3c83f40684; range_end:; response_count:1; response_revision:5408; }","duration":"134.64467ms","start":"2026-04-20T12:04:24.491464Z","end":"2026-04-20T12:04:24.626109Z","steps":["trace[361814951] 'agreement among raft nodes before linearized reading' (duration: 134.036516ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:04:24.949073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.325509ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T12:04:24.949217Z","caller":"traceutil/trace.go:171","msg":"trace[944456621] transaction","detail":"{read_only:false; response_revision:5409; number_of_response:1; }","duration":"318.717574ms","start":"2026-04-20T12:04:24.630479Z","end":"2026-04-20T12:04:24.949197Z","steps":["trace[944456621] 'process raft request' (duration: 200.148498ms)","trace[944456621] 'compare' (duration: 118.163286ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T12:04:24.949275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:04:24.630459Z","time spent":"318.792646ms","remote":"127.0.0.1:47380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":934,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T12:04:25.194327Z","caller":"traceutil/trace.go:171","msg":"trace[790173912] transaction","detail":"{read_only:false; response_revision:5411; number_of_response:1; }","duration":"562.622427ms","start":"2026-04-20T12:04:24.631675Z","end":"2026-04-20T12:04:25.194297Z","steps":["trace[790173912] 'process raft request' (duration: 562.550005ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:04:25.194398Z","caller":"traceutil/trace.go:171","msg":"trace[73181350] transaction","detail":"{read_only:false; response_revision:5412; number_of_response:1; }","duration":"562.582306ms","start":"2026-04-20T12:04:24.631795Z","end":"2026-04-20T12:04:25.194377Z","steps":["trace[73181350] 'process raft request' (duration: 562.454554ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:04:25.194436Z","caller":"traceutil/trace.go:171","msg":"trace[357852366] transaction","detail":"{read_only:false; response_revision:5413; number_of_response:1; }","duration":"562.525345ms","start":"2026-04-20T12:04:24.631872Z","end":"2026-04-20T12:04:25.194397Z","steps":["trace[357852366] 'process raft request' (duration: 562.416572ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:04:25.194503Z","caller":"traceutil/trace.go:171","msg":"trace[1956368421] transaction","detail":"{read_only:false; response_revision:5410; number_of_response:1; }","duration":"563.015676ms","start":"2026-04-20T12:04:24.631476Z","end":"2026-04-20T12:04:25.194491Z","steps":["trace[1956368421] 'process raft request' (duration: 479.752043ms)","trace[1956368421] 'compare' (duration: 82.860954ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T12:04:25.194536Z","caller":"traceutil/trace.go:171","msg":"trace[1689015582] transaction","detail":"{read_only:false; response_revision:5414; number_of_response:1; }","duration":"562.335571ms","start":"2026-04-20T12:04:24.632196Z","end":"2026-04-20T12:04:25.194531Z","steps":["trace[1689015582] 'process raft request' (duration: 562.112786ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:04:25.194557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:04:24.631467Z","time spent":"563.066977ms","remote":"127.0.0.1:47380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":919,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T12:04:25.194566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:04:24.632183Z","time spent":"562.369351ms","remote":"127.0.0.1:47380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":922,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T12:04:25.194587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:04:24.631817Z","time spent":"562.699949ms","remote":"127.0.0.1:47380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":916,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T12:04:25.19451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:04:24.631787Z","time spent":"562.659768ms","remote":"127.0.0.1:47568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T12:04:25.194454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:04:24.631668Z","time spent":"562.72734ms","remote":"127.0.0.1:47380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":919,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T12:04:25.194799Z","caller":"traceutil/trace.go:171","msg":"trace[921438960] transaction","detail":"{read_only:false; response_revision:5415; number_of_response:1; }","duration":"561.121003ms","start":"2026-04-20T12:04:24.633665Z","end":"2026-04-20T12:04:25.194786Z","steps":["trace[921438960] 'process raft request' (duration: 560.672483ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:04:25.194875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:04:24.633652Z","time spent":"561.177814ms","remote":"127.0.0.1:47480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3750,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T12:04:25.195056Z","caller":"traceutil/trace.go:171","msg":"trace[977310019] transaction","detail":"{read_only:false; response_revision:5416; number_of_response:1; }","duration":"559.842014ms","start":"2026-04-20T12:04:24.635191Z","end":"2026-04-20T12:04:25.195033Z","steps":["trace[977310019] 'process raft request' (duration: 559.399404ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:04:25.195098Z","caller":"traceutil/trace.go:171","msg":"trace[1940018102] transaction","detail":"{read_only:false; response_revision:5417; number_of_response:1; }","duration":"559.773831ms","start":"2026-04-20T12:04:24.635315Z","end":"2026-04-20T12:04:25.195089Z","steps":["trace[1940018102] 'process raft request' (duration: 559.502445ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:04:25.195104Z","caller":"traceutil/trace.go:171","msg":"trace[416033416] transaction","detail":"{read_only:false; response_revision:5418; number_of_response:1; }","duration":"555.142667ms","start":"2026-04-20T12:04:24.639941Z","end":"2026-04-20T12:04:25.195084Z","steps":["trace[416033416] 'process raft request' (duration: 555.042465ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:04:25.195139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:04:24.635293Z","time spent":"559.827013ms","remote":"127.0.0.1:47380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":910,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T12:04:25.195173Z","caller":"traceutil/trace.go:171","msg":"trace[834238651] linearizableReadLoop","detail":"{readStateIndex:5617; appliedIndex:5611; }","duration":"562.770731ms","start":"2026-04-20T12:04:24.632369Z","end":"2026-04-20T12:04:25.19514Z","steps":["trace[834238651] 'read index received' (duration: 198.474071ms)","trace[834238651] 'applied index is now lower than readState.Index' (duration: 364.29566ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T12:04:25.19522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:04:24.63993Z","time spent":"555.230839ms","remote":"127.0.0.1:58426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4226,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T12:04:25.195183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:04:24.635181Z","time spent":"559.926456ms","remote":"127.0.0.1:47380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":997,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T12:04:25.195204Z","caller":"traceutil/trace.go:171","msg":"trace[1780639934] transaction","detail":"{read_only:false; response_revision:5419; number_of_response:1; }","duration":"311.05597ms","start":"2026-04-20T12:04:24.884141Z","end":"2026-04-20T12:04:25.195197Z","steps":["trace[1780639934] 'process raft request' (duration: 310.919607ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:04:25.19535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.971135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-04-20T12:04:25.195406Z","caller":"traceutil/trace.go:171","msg":"trace[2094054766] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:5419; }","duration":"563.044436ms","start":"2026-04-20T12:04:24.632344Z","end":"2026-04-20T12:04:25.195389Z","steps":["trace[2094054766] 'agreement among raft nodes before linearized reading' (duration: 562.878352ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:04:25.195407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:04:24.884111Z","time spent":"311.250825ms","remote":"127.0.0.1:47568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T12:04:25.195416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.178206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"warn","ts":"2026-04-20T12:04:25.195449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:04:24.63233Z","time spent":"563.111278ms","remote":"127.0.0.1:47402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":1,"response size":731,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" "} {"level":"warn","ts":"2026-04-20T12:04:25.195452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.246322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1633"} {"level":"info","ts":"2026-04-20T12:04:25.195463Z","caller":"traceutil/trace.go:171","msg":"trace[2020439284] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5419; }","duration":"503.219986ms","start":"2026-04-20T12:04:24.692228Z","end":"2026-04-20T12:04:25.195448Z","steps":["trace[2020439284] 'agreement among raft nodes before linearized reading' (duration: 503.090264ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:04:25.195438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.03708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T12:04:25.195488Z","caller":"traceutil/trace.go:171","msg":"trace[200376151] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:5419; }","duration":"446.339344ms","start":"2026-04-20T12:04:24.74914Z","end":"2026-04-20T12:04:25.195479Z","steps":["trace[200376151] 'agreement among raft nodes before linearized reading' (duration: 446.224542ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:04:25.195494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:04:24.692179Z","time spent":"503.308368ms","remote":"127.0.0.1:47402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1844,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"info","ts":"2026-04-20T12:04:25.195522Z","caller":"traceutil/trace.go:171","msg":"trace[1924710353] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5419; }","duration":"154.163034ms","start":"2026-04-20T12:04:25.041336Z","end":"2026-04-20T12:04:25.195499Z","steps":["trace[1924710353] 'agreement among raft nodes before linearized reading' (duration: 153.99552ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:04:25.195515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:04:24.749108Z","time spent":"446.401446ms","remote":"127.0.0.1:47462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1656,"request content":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" "} {"level":"warn","ts":"2026-04-20T12:04:25.195588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.609063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-20T12:04:25.197119Z","caller":"traceutil/trace.go:171","msg":"trace[1586413328] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5419; }","duration":"130.138857ms","start":"2026-04-20T12:04:25.066963Z","end":"2026-04-20T12:04:25.197101Z","steps":["trace[1586413328] 'agreement among raft nodes before linearized reading' (duration: 128.580642ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:05:21.667981Z","caller":"traceutil/trace.go:171","msg":"trace[230411] linearizableReadLoop","detail":"{readStateIndex:6187; appliedIndex:6185; }","duration":"118.091463ms","start":"2026-04-20T12:05:21.549862Z","end":"2026-04-20T12:05:21.667953Z","steps":["trace[230411] 'read index received' (duration: 44.714976ms)","trace[230411] 'applied index is now lower than readState.Index' (duration: 73.375317ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T12:05:21.668183Z","caller":"traceutil/trace.go:171","msg":"trace[1473900605] transaction","detail":"{read_only:false; response_revision:5968; number_of_response:1; }","duration":"120.486487ms","start":"2026-04-20T12:05:21.547664Z","end":"2026-04-20T12:05:21.668151Z","steps":["trace[1473900605] 'process raft request' (duration: 120.13943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:05:21.668265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.375959ms","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-20T12:05:21.668328Z","caller":"traceutil/trace.go:171","msg":"trace[1235687326] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5968; }","duration":"118.464962ms","start":"2026-04-20T12:05:21.549846Z","end":"2026-04-20T12:05:21.668311Z","steps":["trace[1235687326] 'agreement among raft nodes before linearized reading' (duration: 118.227287ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:05:29.900981Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2969} {"level":"info","ts":"2026-04-20T12:05:30.012149Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2969,"took":"108.995317ms","hash":2668714841,"current-db-size-bytes":56729600,"current-db-size":"57 MB","current-db-size-in-use-bytes":33050624,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-20T12:05:30.012226Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2668714841,"revision":2969,"compact-revision":-1} {"level":"info","ts":"2026-04-20T12:10:29.90774Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6016} {"level":"info","ts":"2026-04-20T12:10:30.002447Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6016,"took":"92.501909ms","hash":1033530209,"current-db-size-bytes":56729600,"current-db-size":"57 MB","current-db-size-in-use-bytes":21774336,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-20T12:10:30.002495Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1033530209,"revision":6016,"compact-revision":2969} {"level":"info","ts":"2026-04-20T12:10:55.832715Z","caller":"traceutil/trace.go:171","msg":"trace[1063090657] transaction","detail":"{read_only:false; response_revision:8403; number_of_response:1; }","duration":"224.798662ms","start":"2026-04-20T12:10:55.607862Z","end":"2026-04-20T12:10:55.83266Z","steps":["trace[1063090657] 'process raft request' (duration: 224.560257ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:10:56.950862Z","caller":"traceutil/trace.go:171","msg":"trace[279876866] transaction","detail":"{read_only:false; response_revision:8405; number_of_response:1; }","duration":"264.111515ms","start":"2026-04-20T12:10:56.686724Z","end":"2026-04-20T12:10:56.950835Z","steps":["trace[279876866] 'process raft request' (duration: 263.93881ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:10:57.444479Z","caller":"traceutil/trace.go:171","msg":"trace[514254180] transaction","detail":"{read_only:false; response_revision:8408; number_of_response:1; }","duration":"128.499707ms","start":"2026-04-20T12:10:57.315738Z","end":"2026-04-20T12:10:57.444238Z","steps":["trace[514254180] 'process raft request' (duration: 128.280552ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:10:57.530474Z","caller":"traceutil/trace.go:171","msg":"trace[1559188510] transaction","detail":"{read_only:false; response_revision:8409; number_of_response:1; }","duration":"140.255773ms","start":"2026-04-20T12:10:57.390172Z","end":"2026-04-20T12:10:57.530428Z","steps":["trace[1559188510] 'process raft request' (duration: 104.788159ms)","trace[1559188510] 'compare' (duration: 35.227529ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T12:10:58.298417Z","caller":"traceutil/trace.go:171","msg":"trace[1471284600] transaction","detail":"{read_only:false; response_revision:8414; number_of_response:1; }","duration":"141.494082ms","start":"2026-04-20T12:10:58.156893Z","end":"2026-04-20T12:10:58.298387Z","steps":["trace[1471284600] 'process raft request' (duration: 141.309167ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:11:25.38764Z","caller":"traceutil/trace.go:171","msg":"trace[1338204507] transaction","detail":"{read_only:false; response_revision:8611; number_of_response:1; }","duration":"144.247375ms","start":"2026-04-20T12:11:25.243367Z","end":"2026-04-20T12:11:25.387614Z","steps":["trace[1338204507] 'process raft request' (duration: 144.042119ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:11:29.292643Z","caller":"traceutil/trace.go:171","msg":"trace[491396348] transaction","detail":"{read_only:false; response_revision:8630; number_of_response:1; }","duration":"157.754051ms","start":"2026-04-20T12:11:29.134844Z","end":"2026-04-20T12:11:29.292598Z","steps":["trace[491396348] 'process raft request' (duration: 157.380322ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:11:29.482601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.320889ms","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-20T12:11:29.482695Z","caller":"traceutil/trace.go:171","msg":"trace[1320337031] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8630; }","duration":"127.468722ms","start":"2026-04-20T12:11:29.355205Z","end":"2026-04-20T12:11:29.482674Z","steps":["trace[1320337031] 'range keys from in-memory index tree' (duration: 127.225088ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:11:38.28796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.929222ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T12:11:38.288111Z","caller":"traceutil/trace.go:171","msg":"trace[1261901741] transaction","detail":"{read_only:false; response_revision:8718; number_of_response:1; }","duration":"601.83074ms","start":"2026-04-20T12:11:37.686246Z","end":"2026-04-20T12:11:38.288077Z","steps":["trace[1261901741] 'process raft request' (duration: 266.681393ms)","trace[1261901741] 'compare' (duration: 334.41337ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T12:11:38.288163Z","caller":"traceutil/trace.go:171","msg":"trace[1071670390] transaction","detail":"{read_only:false; response_revision:8719; number_of_response:1; }","duration":"452.211175ms","start":"2026-04-20T12:11:37.835933Z","end":"2026-04-20T12:11:38.288144Z","steps":["trace[1071670390] 'process raft request' (duration: 452.128443ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:11:38.288252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:11:37.686225Z","time spent":"601.954533ms","remote":"127.0.0.1:47568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T12:11:38.288228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:11:37.835887Z","time spent":"452.313697ms","remote":"127.0.0.1:47380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":746,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T12:11:38.288435Z","caller":"traceutil/trace.go:171","msg":"trace[798168404] linearizableReadLoop","detail":"{readStateIndex:9034; appliedIndex:9033; }","duration":"600.580142ms","start":"2026-04-20T12:11:37.687821Z","end":"2026-04-20T12:11:38.288401Z","steps":["trace[798168404] 'read index received' (duration: 265.118308ms)","trace[798168404] 'applied index is now lower than readState.Index' (duration: 335.458094ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T12:11:38.288726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"600.908399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-6hz5q\" ","response":"range_response_count:1 size:4647"} {"level":"info","ts":"2026-04-20T12:11:38.288812Z","caller":"traceutil/trace.go:171","msg":"trace[1227374996] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-6hz5q; range_end:; response_count:1; response_revision:8719; }","duration":"601.052492ms","start":"2026-04-20T12:11:37.687735Z","end":"2026-04-20T12:11:38.288788Z","steps":["trace[1227374996] 'agreement among raft nodes before linearized reading' (duration: 600.805677ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:11:38.288867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:11:37.687716Z","time spent":"601.138145ms","remote":"127.0.0.1:47480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":4670,"request content":"key:\"/registry/pods/openstack/rook-ceph-detect-version-6hz5q\" "} {"level":"info","ts":"2026-04-20T12:11:38.347055Z","caller":"traceutil/trace.go:171","msg":"trace[1987284111] transaction","detail":"{read_only:false; response_revision:8720; number_of_response:1; }","duration":"351.53527ms","start":"2026-04-20T12:11:37.995478Z","end":"2026-04-20T12:11:38.347013Z","steps":["trace[1987284111] 'process raft request' (duration: 351.290494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:11:38.34722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:11:37.995448Z","time spent":"351.691603ms","remote":"127.0.0.1:47568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T12:11:38.371753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.980158ms","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-20T12:11:38.371851Z","caller":"traceutil/trace.go:171","msg":"trace[10527373] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8720; }","duration":"589.130371ms","start":"2026-04-20T12:11:37.782704Z","end":"2026-04-20T12:11:38.371834Z","steps":["trace[10527373] 'agreement among raft nodes before linearized reading' (duration: 588.928887ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:11:38.371893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:11:37.782678Z","time spent":"589.206303ms","remote":"127.0.0.1:47568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T12:11:38.371878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.207793ms","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-20T12:11:38.371974Z","caller":"traceutil/trace.go:171","msg":"trace[1628546419] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8720; }","duration":"318.346596ms","start":"2026-04-20T12:11:38.053606Z","end":"2026-04-20T12:11:38.371952Z","steps":["trace[1628546419] 'agreement among raft nodes before linearized reading' (duration: 318.035028ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:11:38.372034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:11:38.053589Z","time spent":"318.432647ms","remote":"127.0.0.1:47568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-20T12:11:38.372115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.136719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-6hz5q\" ","response":"range_response_count:1 size:4647"} {"level":"info","ts":"2026-04-20T12:11:38.372152Z","caller":"traceutil/trace.go:171","msg":"trace[1815870776] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-6hz5q; range_end:; response_count:1; response_revision:8720; }","duration":"536.233391ms","start":"2026-04-20T12:11:37.835909Z","end":"2026-04-20T12:11:38.372142Z","steps":["trace[1815870776] 'agreement among raft nodes before linearized reading' (duration: 536.139059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:11:38.372178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:11:37.835883Z","time spent":"536.289233ms","remote":"127.0.0.1:47480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":4670,"request content":"key:\"/registry/pods/openstack/rook-ceph-detect-version-6hz5q\" "} {"level":"warn","ts":"2026-04-20T12:11:38.37228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.800776ms","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":"info","ts":"2026-04-20T12:11:38.372341Z","caller":"traceutil/trace.go:171","msg":"trace[1789018965] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:8720; }","duration":"114.911748ms","start":"2026-04-20T12:11:38.257413Z","end":"2026-04-20T12:11:38.372325Z","steps":["trace[1789018965] 'agreement among raft nodes before linearized reading' (duration: 114.821906ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:11:38.372367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.467427ms","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-20T12:11:38.372402Z","caller":"traceutil/trace.go:171","msg":"trace[603878161] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8720; }","duration":"551.501758ms","start":"2026-04-20T12:11:37.820891Z","end":"2026-04-20T12:11:38.372393Z","steps":["trace[603878161] 'agreement among raft nodes before linearized reading' (duration: 551.413626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:11:38.372428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:11:37.820817Z","time spent":"551.605009ms","remote":"127.0.0.1:47568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-20T12:12:03.091908Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002467.wal"} {"level":"info","ts":"2026-04-20T12:12:39.83804Z","caller":"traceutil/trace.go:171","msg":"trace[1576503526] transaction","detail":"{read_only:false; response_revision:9381; number_of_response:1; }","duration":"105.541016ms","start":"2026-04-20T12:12:39.732477Z","end":"2026-04-20T12:12:39.838018Z","steps":["trace[1576503526] 'process raft request' (duration: 105.402183ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:12:52.833234Z","caller":"traceutil/trace.go:171","msg":"trace[120584903] linearizableReadLoop","detail":"{readStateIndex:9792; appliedIndex:9791; }","duration":"205.928525ms","start":"2026-04-20T12:12:52.627283Z","end":"2026-04-20T12:12:52.833212Z","steps":["trace[120584903] 'read index received' (duration: 205.791852ms)","trace[120584903] 'applied index is now lower than readState.Index' (duration: 135.463µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T12:12:52.833287Z","caller":"traceutil/trace.go:171","msg":"trace[1713033245] transaction","detail":"{read_only:false; response_revision:9457; number_of_response:1; }","duration":"243.262482ms","start":"2026-04-20T12:12:52.58999Z","end":"2026-04-20T12:12:52.833253Z","steps":["trace[1713033245] 'process raft request' (duration: 243.077388ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:12:52.833433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.141779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-20T12:12:52.833468Z","caller":"traceutil/trace.go:171","msg":"trace[1040541739] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9457; }","duration":"206.228401ms","start":"2026-04-20T12:12:52.627227Z","end":"2026-04-20T12:12:52.833456Z","steps":["trace[1040541739] 'agreement among raft nodes before linearized reading' (duration: 206.097719ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:12:52.834099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.308567ms","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":"info","ts":"2026-04-20T12:12:52.834276Z","caller":"traceutil/trace.go:171","msg":"trace[901287777] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:9457; }","duration":"148.545032ms","start":"2026-04-20T12:12:52.685705Z","end":"2026-04-20T12:12:52.83425Z","steps":["trace[901287777] 'agreement among raft nodes before linearized reading' (duration: 147.98067ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:12:53.0011Z","caller":"traceutil/trace.go:171","msg":"trace[745628589] transaction","detail":"{read_only:false; response_revision:9460; number_of_response:1; }","duration":"162.145711ms","start":"2026-04-20T12:12:52.838928Z","end":"2026-04-20T12:12:53.001074Z","steps":["trace[745628589] 'process raft request' (duration: 162.045458ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:12:53.001145Z","caller":"traceutil/trace.go:171","msg":"trace[1059862173] transaction","detail":"{read_only:false; response_revision:9459; number_of_response:1; }","duration":"162.654162ms","start":"2026-04-20T12:12:52.838449Z","end":"2026-04-20T12:12:53.001103Z","steps":["trace[1059862173] 'process raft request' (duration: 162.257323ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:12:53.001243Z","caller":"traceutil/trace.go:171","msg":"trace[1863680008] linearizableReadLoop","detail":"{readStateIndex:9796; appliedIndex:9793; }","duration":"126.218175ms","start":"2026-04-20T12:12:52.87501Z","end":"2026-04-20T12:12:53.001228Z","steps":["trace[1863680008] 'read index received' (duration: 125.593331ms)","trace[1863680008] 'applied index is now lower than readState.Index' (duration: 623.604µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T12:12:53.001325Z","caller":"traceutil/trace.go:171","msg":"trace[751063558] transaction","detail":"{read_only:false; response_revision:9461; number_of_response:1; }","duration":"162.347005ms","start":"2026-04-20T12:12:52.838966Z","end":"2026-04-20T12:12:53.001313Z","steps":["trace[751063558] 'process raft request' (duration: 162.065049ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:12:53.001379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.369149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.30\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-20T12:12:53.001412Z","caller":"traceutil/trace.go:171","msg":"trace[1694796158] range","detail":"{range_begin:/registry/masterleases/199.19.213.30; range_end:; response_count:1; response_revision:9461; }","duration":"126.450411ms","start":"2026-04-20T12:12:52.874952Z","end":"2026-04-20T12:12:53.001403Z","steps":["trace[1694796158] 'agreement among raft nodes before linearized reading' (duration: 126.325588ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:13:20.053536Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e2b5783e11defe7e","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-20T12:13:20.06016Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-20T12:13:20.060254Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-20T12:15:10.152124Z","caller":"traceutil/trace.go:171","msg":"trace[1827948898] transaction","detail":"{read_only:false; response_revision:10506; number_of_response:1; }","duration":"108.492091ms","start":"2026-04-20T12:15:10.043612Z","end":"2026-04-20T12:15:10.152104Z","steps":["trace[1827948898] 'process raft request' (duration: 108.345868ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:15:10.253711Z","caller":"traceutil/trace.go:171","msg":"trace[458066429] linearizableReadLoop","detail":"{readStateIndex:10875; appliedIndex:10874; }","duration":"129.672073ms","start":"2026-04-20T12:15:10.124015Z","end":"2026-04-20T12:15:10.253687Z","steps":["trace[458066429] 'read index received' (duration: 28.239321ms)","trace[458066429] 'applied index is now lower than readState.Index' (duration: 101.431222ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T12:15:10.253848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.810336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T12:15:10.25388Z","caller":"traceutil/trace.go:171","msg":"trace[554256893] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:10508; }","duration":"129.892298ms","start":"2026-04-20T12:15:10.123979Z","end":"2026-04-20T12:15:10.253871Z","steps":["trace[554256893] 'agreement among raft nodes before linearized reading' (duration: 129.798566ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:15:10.254087Z","caller":"traceutil/trace.go:171","msg":"trace[1390334447] transaction","detail":"{read_only:false; response_revision:10508; number_of_response:1; }","duration":"109.940985ms","start":"2026-04-20T12:15:10.144109Z","end":"2026-04-20T12:15:10.25405Z","steps":["trace[1390334447] 'process raft request' (duration: 109.519405ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:15:10.254263Z","caller":"traceutil/trace.go:171","msg":"trace[1380579657] transaction","detail":"{read_only:false; response_revision:10507; number_of_response:1; }","duration":"137.327986ms","start":"2026-04-20T12:15:10.116902Z","end":"2026-04-20T12:15:10.25423Z","steps":["trace[1380579657] 'process raft request' (duration: 92.962469ms)","trace[1380579657] 'compare' (duration: 43.608259ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T12:15:29.912791Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8124} {"level":"info","ts":"2026-04-20T12:15:29.975834Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8124,"took":"60.80794ms","hash":3762149183,"current-db-size-bytes":56729600,"current-db-size":"57 MB","current-db-size-in-use-bytes":29147136,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-20T12:15:29.9759Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3762149183,"revision":8124,"compact-revision":6016} {"level":"info","ts":"2026-04-20T12:20:29.920066Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10654} {"level":"info","ts":"2026-04-20T12:20:30.006773Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10654,"took":"83.581118ms","hash":877007256,"current-db-size-bytes":56729600,"current-db-size":"57 MB","current-db-size-in-use-bytes":21409792,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-20T12:20:30.006821Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":877007256,"revision":10654,"compact-revision":8124}