{"level":"warn","ts":"2026-04-21T17:06:26.063671Z","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-21T17:06:26.063913Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.3: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.3:2380","--initial-cluster=instance=https://199.19.213.3:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.3:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.3: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-21T17:06:26.064023Z","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-21T17:06:26.06407Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.3:2380"]} {"level":"info","ts":"2026-04-21T17:06:26.064143Z","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-21T17:06:26.064836Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.3:2379"]} {"level":"info","ts":"2026-04-21T17:06:26.064975Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.3:2380"],"listen-peer-urls":["https://199.19.213.3:2380"],"advertise-client-urls":["https://199.19.213.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.3: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-21T17:06:26.073275Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.634059ms"} {"level":"info","ts":"2026-04-21T17:06:26.080907Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3cf904ec39d3e333","cluster-id":"7b1ae51097bedd0e"} {"level":"info","ts":"2026-04-21T17:06:26.081041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 switched to configuration voters=()"} {"level":"info","ts":"2026-04-21T17:06:26.081124Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 became follower at term 0"} {"level":"info","ts":"2026-04-21T17:06:26.081183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3cf904ec39d3e333 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-21T17:06:26.081241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 became follower at term 1"} {"level":"info","ts":"2026-04-21T17:06:26.081324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 switched to configuration voters=(4393548324105610035)"} {"level":"warn","ts":"2026-04-21T17:06:26.088506Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-21T17:06:26.089752Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-21T17:06:26.090696Z","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-21T17:06:26.092922Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3cf904ec39d3e333","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-21T17:06:26.093256Z","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-21T17:06:26.093324Z","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-21T17:06:26.093208Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3cf904ec39d3e333","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-21T17:06:26.093397Z","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-21T17:06:26.094389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 switched to configuration voters=(4393548324105610035)"} {"level":"info","ts":"2026-04-21T17:06:26.095467Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7b1ae51097bedd0e","local-member-id":"3cf904ec39d3e333","added-peer-id":"3cf904ec39d3e333","added-peer-peer-urls":["https://199.19.213.3:2380"]} {"level":"info","ts":"2026-04-21T17:06:26.101426Z","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-21T17:06:26.101469Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.3:2380"} {"level":"info","ts":"2026-04-21T17:06:26.101497Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.3:2380"} {"level":"info","ts":"2026-04-21T17:06:26.101701Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3cf904ec39d3e333","initial-advertise-peer-urls":["https://199.19.213.3:2380"],"listen-peer-urls":["https://199.19.213.3:2380"],"advertise-client-urls":["https://199.19.213.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-21T17:06:26.101729Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-21T17:06:27.082573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 is starting a new election at term 1"} {"level":"info","ts":"2026-04-21T17:06:27.08268Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-21T17:06:27.082709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 received MsgPreVoteResp from 3cf904ec39d3e333 at term 1"} {"level":"info","ts":"2026-04-21T17:06:27.082729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 became candidate at term 2"} {"level":"info","ts":"2026-04-21T17:06:27.082739Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 received MsgVoteResp from 3cf904ec39d3e333 at term 2"} {"level":"info","ts":"2026-04-21T17:06:27.082755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 became leader at term 2"} {"level":"info","ts":"2026-04-21T17:06:27.082768Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3cf904ec39d3e333 elected leader 3cf904ec39d3e333 at term 2"} {"level":"info","ts":"2026-04-21T17:06:27.083638Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3cf904ec39d3e333","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.3:2379]}","request-path":"/0/members/3cf904ec39d3e333/attributes","cluster-id":"7b1ae51097bedd0e","publish-timeout":"7s"} {"level":"info","ts":"2026-04-21T17:06:27.083667Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:06:27.083899Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T17:06:27.08394Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T17:06:27.084294Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-21T17:06:27.084352Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-21T17:06:27.085417Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7b1ae51097bedd0e","local-member-id":"3cf904ec39d3e333","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:06:27.08558Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:06:27.085632Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:06:27.087279Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-21T17:06:27.087422Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.3:2379"} {"level":"warn","ts":"2026-04-21T17:06:42.17131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.455115ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T17:06:42.171466Z","caller":"traceutil/trace.go:171","msg":"trace[1300416911] linearizableReadLoop","detail":"{readStateIndex:419; appliedIndex:418; }","duration":"179.171346ms","start":"2026-04-21T17:06:41.992273Z","end":"2026-04-21T17:06:42.171444Z","steps":["trace[1300416911] 'read index received' (duration: 29.541µs)","trace[1300416911] 'applied index is now lower than readState.Index' (duration: 179.139715ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:06:42.17151Z","caller":"traceutil/trace.go:171","msg":"trace[1292734662] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"400.47371ms","start":"2026-04-21T17:06:41.770997Z","end":"2026-04-21T17:06:42.171471Z","steps":["trace[1292734662] 'process raft request' (duration: 200.253873ms)","trace[1292734662] 'compare' (duration: 199.284682ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:06:42.171626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.316178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-21T17:06:42.171681Z","caller":"traceutil/trace.go:171","msg":"trace[1947141086] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:406; }","duration":"179.4261ms","start":"2026-04-21T17:06:41.99224Z","end":"2026-04-21T17:06:42.171666Z","steps":["trace[1947141086] 'agreement among raft nodes before linearized reading' (duration: 179.292997ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:06:42.171678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:06:41.770993Z","time spent":"400.597682ms","remote":"127.0.0.1:55174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:06:59.315126Z","caller":"traceutil/trace.go:171","msg":"trace[2005883207] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"148.565382ms","start":"2026-04-21T17:06:59.166533Z","end":"2026-04-21T17:06:59.315099Z","steps":["trace[2005883207] 'process raft request' (duration: 148.329818ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:06:59.316136Z","caller":"traceutil/trace.go:171","msg":"trace[223893166] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:610; }","duration":"146.768384ms","start":"2026-04-21T17:06:59.169356Z","end":"2026-04-21T17:06:59.316125Z","steps":["trace[223893166] 'read index received' (duration: 146.763514ms)","trace[223893166] 'applied index is now lower than readState.Index' (duration: 4.22µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:06:59.316365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.986267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570105"} {"level":"info","ts":"2026-04-21T17:06:59.316408Z","caller":"traceutil/trace.go:171","msg":"trace[706626808] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:589; }","duration":"147.088729ms","start":"2026-04-21T17:06:59.169304Z","end":"2026-04-21T17:06:59.316393Z","steps":["trace[706626808] 'agreement among raft nodes before linearized reading' (duration: 146.870476ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:07:03.988826Z","caller":"traceutil/trace.go:171","msg":"trace[1890246332] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"174.974657ms","start":"2026-04-21T17:07:03.813784Z","end":"2026-04-21T17:07:03.988759Z","steps":["trace[1890246332] 'read index received' (duration: 170.278145ms)","trace[1890246332] 'applied index is now lower than readState.Index' (duration: 4.694992ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:07:03.989085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.276311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-x6qng\" ","response":"range_response_count:1 size:16957"} {"level":"info","ts":"2026-04-21T17:07:03.989145Z","caller":"traceutil/trace.go:171","msg":"trace[1367557757] range","detail":"{range_begin:/registry/pods/kube-system/cilium-x6qng; range_end:; response_count:1; response_revision:617; }","duration":"175.378292ms","start":"2026-04-21T17:07:03.813745Z","end":"2026-04-21T17:07:03.989123Z","steps":["trace[1367557757] 'agreement among raft nodes before linearized reading' (duration: 175.148759ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:07:03.991038Z","caller":"traceutil/trace.go:171","msg":"trace[373650058] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"184.50517ms","start":"2026-04-21T17:07:03.806488Z","end":"2026-04-21T17:07:03.990993Z","steps":["trace[373650058] 'process raft request' (duration: 181.688697ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:07:04.151899Z","caller":"traceutil/trace.go:171","msg":"trace[409567135] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"145.424159ms","start":"2026-04-21T17:07:04.006446Z","end":"2026-04-21T17:07:04.15187Z","steps":["trace[409567135] 'process raft request' (duration: 131.779152ms)","trace[409567135] 'compare' (duration: 13.356442ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:07:04.173243Z","caller":"traceutil/trace.go:171","msg":"trace[323719554] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"124.521753ms","start":"2026-04-21T17:07:04.048696Z","end":"2026-04-21T17:07:04.173218Z","steps":["trace[323719554] 'process raft request' (duration: 124.400231ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:07:04.629964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.940647ms","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-21T17:07:04.630061Z","caller":"traceutil/trace.go:171","msg":"trace[561623349] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:619; }","duration":"277.100199ms","start":"2026-04-21T17:07:04.352933Z","end":"2026-04-21T17:07:04.630033Z","steps":["trace[561623349] 'range keys from in-memory index tree' (duration: 276.751064ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:07:04.630142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.26186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-21T17:07:04.630215Z","caller":"traceutil/trace.go:171","msg":"trace[975796073] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:619; }","duration":"253.374371ms","start":"2026-04-21T17:07:04.376824Z","end":"2026-04-21T17:07:04.630198Z","steps":["trace[975796073] 'range keys from in-memory index tree' (duration: 253.114847ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:07:47.245179Z","caller":"traceutil/trace.go:171","msg":"trace[31103258] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"233.720327ms","start":"2026-04-21T17:07:47.01143Z","end":"2026-04-21T17:07:47.24515Z","steps":["trace[31103258] 'process raft request' (duration: 207.343236ms)","trace[31103258] 'compare' (duration: 26.082497ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:07:47.245647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.307917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:07:47.245741Z","caller":"traceutil/trace.go:171","msg":"trace[1783188639] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1179; }","duration":"104.440338ms","start":"2026-04-21T17:07:47.141282Z","end":"2026-04-21T17:07:47.245722Z","steps":["trace[1783188639] 'agreement among raft nodes before linearized reading' (duration: 104.266356ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:07:47.245145Z","caller":"traceutil/trace.go:171","msg":"trace[746601118] linearizableReadLoop","detail":"{readStateIndex:1215; appliedIndex:1214; }","duration":"103.79235ms","start":"2026-04-21T17:07:47.141313Z","end":"2026-04-21T17:07:47.245105Z","steps":["trace[746601118] 'read index received' (duration: 77.393159ms)","trace[746601118] 'applied index is now lower than readState.Index' (duration: 26.397381ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:08:35.153227Z","caller":"traceutil/trace.go:171","msg":"trace[968324449] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"187.609837ms","start":"2026-04-21T17:08:34.965585Z","end":"2026-04-21T17:08:35.153195Z","steps":["trace[968324449] 'process raft request' (duration: 187.420875ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:08:35.162012Z","caller":"traceutil/trace.go:171","msg":"trace[84345353] linearizableReadLoop","detail":"{readStateIndex:1914; appliedIndex:1912; }","duration":"176.145685ms","start":"2026-04-21T17:08:34.985838Z","end":"2026-04-21T17:08:35.161984Z","steps":["trace[84345353] 'read index received' (duration: 167.263396ms)","trace[84345353] 'applied index is now lower than readState.Index' (duration: 8.881329ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:08:35.162137Z","caller":"traceutil/trace.go:171","msg":"trace[442642496] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"196.356894ms","start":"2026-04-21T17:08:34.965767Z","end":"2026-04-21T17:08:35.162124Z","steps":["trace[442642496] 'process raft request' (duration: 196.08085ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:08:35.162403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.5511ms","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-21T17:08:35.162449Z","caller":"traceutil/trace.go:171","msg":"trace[574518134] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1840; }","duration":"176.648561ms","start":"2026-04-21T17:08:34.98579Z","end":"2026-04-21T17:08:35.162438Z","steps":["trace[574518134] 'agreement among raft nodes before linearized reading' (duration: 176.54049ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:08:35.576902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.431632ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T17:08:35.577065Z","caller":"traceutil/trace.go:171","msg":"trace[671435156] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"409.789026ms","start":"2026-04-21T17:08:35.167257Z","end":"2026-04-21T17:08:35.577046Z","steps":["trace[671435156] 'process raft request' (duration: 153.123421ms)","trace[671435156] 'compare' (duration: 256.323571ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:08:35.577207Z","caller":"traceutil/trace.go:171","msg":"trace[993744160] linearizableReadLoop","detail":"{readStateIndex:1917; appliedIndex:1915; }","duration":"395.120046ms","start":"2026-04-21T17:08:35.182071Z","end":"2026-04-21T17:08:35.577191Z","steps":["trace[993744160] 'read index received' (duration: 138.38873ms)","trace[993744160] 'applied index is now lower than readState.Index' (duration: 256.730096ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:08:35.57729Z","caller":"traceutil/trace.go:171","msg":"trace[1530315370] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"407.780413ms","start":"2026-04-21T17:08:35.169499Z","end":"2026-04-21T17:08:35.57728Z","steps":["trace[1530315370] 'process raft request' (duration: 407.499309ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:08:35.57739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:08:35.169442Z","time spent":"407.876243ms","remote":"127.0.0.1:55174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:08:35.577264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:08:35.167248Z","time spent":"409.977128ms","remote":"127.0.0.1:55174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:08:35.601468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.378064ms","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-21T17:08:35.601548Z","caller":"traceutil/trace.go:171","msg":"trace[172769728] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1843; }","duration":"419.497116ms","start":"2026-04-21T17:08:35.182029Z","end":"2026-04-21T17:08:35.601526Z","steps":["trace[172769728] 'agreement among raft nodes before linearized reading' (duration: 395.500631ms)","trace[172769728] 'range keys from in-memory index tree' (duration: 23.815213ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:08:35.601709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:08:35.182009Z","time spent":"419.683928ms","remote":"127.0.0.1:55174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-21T17:08:35.601782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.812536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4f94a4a1-44d2-4189-a329-d3549d559826\" ","response":"range_response_count:1 size:3625"} {"level":"info","ts":"2026-04-21T17:08:35.60185Z","caller":"traceutil/trace.go:171","msg":"trace[1283164306] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4f94a4a1-44d2-4189-a329-d3549d559826; range_end:; response_count:1; response_revision:1844; }","duration":"343.909947ms","start":"2026-04-21T17:08:35.257919Z","end":"2026-04-21T17:08:35.601829Z","steps":["trace[1283164306] 'agreement among raft nodes before linearized reading' (duration: 343.702194ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:08:35.601905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:08:35.257899Z","time spent":"343.994138ms","remote":"127.0.0.1:55112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3647,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4f94a4a1-44d2-4189-a329-d3549d559826\" "} {"level":"warn","ts":"2026-04-21T17:08:35.602015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.416743ms","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-21T17:08:35.602055Z","caller":"traceutil/trace.go:171","msg":"trace[1260283909] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1844; }","duration":"117.458043ms","start":"2026-04-21T17:08:35.484587Z","end":"2026-04-21T17:08:35.602045Z","steps":["trace[1260283909] 'agreement among raft nodes before linearized reading' (duration: 117.330432ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:08:35.716132Z","caller":"traceutil/trace.go:171","msg":"trace[661818617] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"108.350492ms","start":"2026-04-21T17:08:35.607751Z","end":"2026-04-21T17:08:35.716101Z","steps":["trace[661818617] 'process raft request' (duration: 79.113982ms)","trace[661818617] 'compare' (duration: 29.098168ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:08:35.784437Z","caller":"traceutil/trace.go:171","msg":"trace[1533685477] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"175.496948ms","start":"2026-04-21T17:08:35.608905Z","end":"2026-04-21T17:08:35.784402Z","steps":["trace[1533685477] 'process raft request' (duration: 175.344186ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:08:35.784667Z","caller":"traceutil/trace.go:171","msg":"trace[1421498918] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"176.51021ms","start":"2026-04-21T17:08:35.608132Z","end":"2026-04-21T17:08:35.784642Z","steps":["trace[1421498918] 'process raft request' (duration: 175.864412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:08:35.945766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.03175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:08:35.945828Z","caller":"traceutil/trace.go:171","msg":"trace[1448756675] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1847; }","duration":"100.128491ms","start":"2026-04-21T17:08:35.845684Z","end":"2026-04-21T17:08:35.945812Z","steps":["trace[1448756675] 'count revisions from in-memory index tree' (duration: 99.943019ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:09:05.552892Z","caller":"traceutil/trace.go:171","msg":"trace[918571976] transaction","detail":"{read_only:false; response_revision:2062; number_of_response:1; }","duration":"215.165373ms","start":"2026-04-21T17:09:05.337691Z","end":"2026-04-21T17:09:05.552856Z","steps":["trace[918571976] 'process raft request' (duration: 214.576776ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:09:05.552941Z","caller":"traceutil/trace.go:171","msg":"trace[328526088] linearizableReadLoop","detail":"{readStateIndex:2145; appliedIndex:2143; }","duration":"207.152767ms","start":"2026-04-21T17:09:05.345753Z","end":"2026-04-21T17:09:05.552906Z","steps":["trace[328526088] 'read index received' (duration: 206.56878ms)","trace[328526088] 'applied index is now lower than readState.Index' (duration: 582.207µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:09:05.553065Z","caller":"traceutil/trace.go:171","msg":"trace[718001790] transaction","detail":"{read_only:false; response_revision:2063; number_of_response:1; }","duration":"215.211704ms","start":"2026-04-21T17:09:05.33783Z","end":"2026-04-21T17:09:05.553042Z","steps":["trace[718001790] 'process raft request' (duration: 214.89733ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:09:05.553232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.460201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-21T17:09:05.553294Z","caller":"traceutil/trace.go:171","msg":"trace[300992028] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2063; }","duration":"207.571223ms","start":"2026-04-21T17:09:05.345704Z","end":"2026-04-21T17:09:05.553275Z","steps":["trace[300992028] 'agreement among raft nodes before linearized reading' (duration: 207.381811ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:09:05.553409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.140372ms","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-21T17:09:05.553459Z","caller":"traceutil/trace.go:171","msg":"trace[97097847] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2063; }","duration":"163.228773ms","start":"2026-04-21T17:09:05.390217Z","end":"2026-04-21T17:09:05.553445Z","steps":["trace[97097847] 'agreement among raft nodes before linearized reading' (duration: 163.066061ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:09:05.978214Z","caller":"traceutil/trace.go:171","msg":"trace[258671280] transaction","detail":"{read_only:false; response_revision:2067; number_of_response:1; }","duration":"143.636307ms","start":"2026-04-21T17:09:05.834539Z","end":"2026-04-21T17:09:05.978175Z","steps":["trace[258671280] 'process raft request' (duration: 143.511456ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:09:05.978778Z","caller":"traceutil/trace.go:171","msg":"trace[594284198] transaction","detail":"{read_only:false; response_revision:2066; number_of_response:1; }","duration":"144.6791ms","start":"2026-04-21T17:09:05.833945Z","end":"2026-04-21T17:09:05.978624Z","steps":["trace[594284198] 'process raft request' (duration: 101.929729ms)","trace[594284198] 'compare' (duration: 41.87803ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:09:07.709929Z","caller":"traceutil/trace.go:171","msg":"trace[1454098286] transaction","detail":"{read_only:false; response_revision:2072; number_of_response:1; }","duration":"150.87164ms","start":"2026-04-21T17:09:07.559033Z","end":"2026-04-21T17:09:07.709904Z","steps":["trace[1454098286] 'process raft request' (duration: 150.667168ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:09:07.711986Z","caller":"traceutil/trace.go:171","msg":"trace[1995616391] linearizableReadLoop","detail":"{readStateIndex:2155; appliedIndex:2154; }","duration":"118.544575ms","start":"2026-04-21T17:09:07.59342Z","end":"2026-04-21T17:09:07.711965Z","steps":["trace[1995616391] 'read index received' (duration: 116.552621ms)","trace[1995616391] 'applied index is now lower than readState.Index' (duration: 1.990914ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:09:07.712255Z","caller":"traceutil/trace.go:171","msg":"trace[1207683617] transaction","detail":"{read_only:false; response_revision:2073; number_of_response:1; }","duration":"152.615301ms","start":"2026-04-21T17:09:07.559552Z","end":"2026-04-21T17:09:07.712167Z","steps":["trace[1207683617] 'process raft request' (duration: 152.302398ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:09:07.712419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.938299ms","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-21T17:09:07.712519Z","caller":"traceutil/trace.go:171","msg":"trace[460922690] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2073; }","duration":"119.079122ms","start":"2026-04-21T17:09:07.593376Z","end":"2026-04-21T17:09:07.712455Z","steps":["trace[460922690] 'agreement among raft nodes before linearized reading' (duration: 118.797548ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:10:50.719921Z","caller":"traceutil/trace.go:171","msg":"trace[166763404] linearizableReadLoop","detail":"{readStateIndex:2839; appliedIndex:2838; }","duration":"145.439778ms","start":"2026-04-21T17:10:50.574449Z","end":"2026-04-21T17:10:50.719889Z","steps":["trace[166763404] 'read index received' (duration: 145.275185ms)","trace[166763404] 'applied index is now lower than readState.Index' (duration: 163.363µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:10:50.720054Z","caller":"traceutil/trace.go:171","msg":"trace[326101991] transaction","detail":"{read_only:false; response_revision:2733; number_of_response:1; }","duration":"146.408029ms","start":"2026-04-21T17:10:50.573631Z","end":"2026-04-21T17:10:50.720039Z","steps":["trace[326101991] 'process raft request' (duration: 146.112343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:10:50.720373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.889888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-21T17:10:50.720473Z","caller":"traceutil/trace.go:171","msg":"trace[214227159] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2733; }","duration":"146.01918ms","start":"2026-04-21T17:10:50.574427Z","end":"2026-04-21T17:10:50.720446Z","steps":["trace[214227159] 'agreement among raft nodes before linearized reading' (duration: 145.775065ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:10:50.797142Z","caller":"traceutil/trace.go:171","msg":"trace[1653051809] transaction","detail":"{read_only:false; response_revision:2734; number_of_response:1; }","duration":"220.077814ms","start":"2026-04-21T17:10:50.577038Z","end":"2026-04-21T17:10:50.797115Z","steps":["trace[1653051809] 'process raft request' (duration: 219.965442ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:10:50.797293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.128934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-21T17:10:50.797343Z","caller":"traceutil/trace.go:171","msg":"trace[1638427495] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2734; }","duration":"220.215428ms","start":"2026-04-21T17:10:50.577116Z","end":"2026-04-21T17:10:50.797332Z","steps":["trace[1638427495] 'agreement among raft nodes before linearized reading' (duration: 220.007562ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:26.083913Z","caller":"traceutil/trace.go:171","msg":"trace[906665068] transaction","detail":"{read_only:false; response_revision:4469; number_of_response:1; }","duration":"106.243839ms","start":"2026-04-21T17:14:25.977646Z","end":"2026-04-21T17:14:26.08389Z","steps":["trace[906665068] 'process raft request' (duration: 95.043914ms)","trace[906665068] 'compare' (duration: 11.041293ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:14:26.084347Z","caller":"traceutil/trace.go:171","msg":"trace[9740269] transaction","detail":"{read_only:false; response_revision:4470; number_of_response:1; }","duration":"106.682486ms","start":"2026-04-21T17:14:25.977643Z","end":"2026-04-21T17:14:26.084326Z","steps":["trace[9740269] 'process raft request' (duration: 106.193699ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:37.191894Z","caller":"traceutil/trace.go:171","msg":"trace[1326194750] transaction","detail":"{read_only:false; response_revision:4637; number_of_response:1; }","duration":"233.606009ms","start":"2026-04-21T17:14:36.958258Z","end":"2026-04-21T17:14:37.191864Z","steps":["trace[1326194750] 'process raft request' (duration: 233.408335ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:37.199361Z","caller":"traceutil/trace.go:171","msg":"trace[460961841] transaction","detail":"{read_only:false; response_revision:4638; number_of_response:1; }","duration":"238.724352ms","start":"2026-04-21T17:14:36.960614Z","end":"2026-04-21T17:14:37.199338Z","steps":["trace[460961841] 'process raft request' (duration: 238.55026ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:37.199539Z","caller":"traceutil/trace.go:171","msg":"trace[404065857] transaction","detail":"{read_only:false; response_revision:4639; number_of_response:1; }","duration":"140.11308ms","start":"2026-04-21T17:14:37.059405Z","end":"2026-04-21T17:14:37.199518Z","steps":["trace[404065857] 'process raft request' (duration: 139.894047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:37.199838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.374169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12969"} {"level":"info","ts":"2026-04-21T17:14:37.199886Z","caller":"traceutil/trace.go:171","msg":"trace[1878427395] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4639; }","duration":"191.483411ms","start":"2026-04-21T17:14:37.008388Z","end":"2026-04-21T17:14:37.199871Z","steps":["trace[1878427395] 'agreement among raft nodes before linearized reading' (duration: 191.288968ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:37.199573Z","caller":"traceutil/trace.go:171","msg":"trace[736431683] linearizableReadLoop","detail":"{readStateIndex:4819; appliedIndex:4817; }","duration":"191.105925ms","start":"2026-04-21T17:14:37.008443Z","end":"2026-04-21T17:14:37.199549Z","steps":["trace[736431683] 'read index received' (duration: 183.303681ms)","trace[736431683] 'applied index is now lower than readState.Index' (duration: 7.800394ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:14:37.200197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.513197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-585c485889-tnf4l.18a86e9d8ec42a67\" ","response":"range_response_count:1 size:898"} {"level":"info","ts":"2026-04-21T17:14:37.200239Z","caller":"traceutil/trace.go:171","msg":"trace[25141757] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-585c485889-tnf4l.18a86e9d8ec42a67; range_end:; response_count:1; response_revision:4639; }","duration":"188.60632ms","start":"2026-04-21T17:14:37.011618Z","end":"2026-04-21T17:14:37.200224Z","steps":["trace[25141757] 'agreement among raft nodes before linearized reading' (duration: 188.437127ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:37.200452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.778246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T17:14:37.200505Z","caller":"traceutil/trace.go:171","msg":"trace[1447237559] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:4639; }","duration":"137.837707ms","start":"2026-04-21T17:14:37.062651Z","end":"2026-04-21T17:14:37.200489Z","steps":["trace[1447237559] 'agreement among raft nodes before linearized reading' (duration: 137.744966ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:37.20057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.280675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-04-21T17:14:37.200623Z","caller":"traceutil/trace.go:171","msg":"trace[1554581730] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4639; }","duration":"106.369567ms","start":"2026-04-21T17:14:37.094238Z","end":"2026-04-21T17:14:37.200608Z","steps":["trace[1554581730] 'agreement among raft nodes before linearized reading' (duration: 106.135613ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:37.582474Z","caller":"traceutil/trace.go:171","msg":"trace[742822420] linearizableReadLoop","detail":"{readStateIndex:4828; appliedIndex:4827; }","duration":"162.541738ms","start":"2026-04-21T17:14:37.419911Z","end":"2026-04-21T17:14:37.582453Z","steps":["trace[742822420] 'read index received' (duration: 162.403906ms)","trace[742822420] 'applied index is now lower than readState.Index' (duration: 137.081µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:14:37.582577Z","caller":"traceutil/trace.go:171","msg":"trace[1081359859] transaction","detail":"{read_only:false; response_revision:4647; number_of_response:1; }","duration":"214.665151ms","start":"2026-04-21T17:14:37.367876Z","end":"2026-04-21T17:14:37.582541Z","steps":["trace[1081359859] 'process raft request' (duration: 214.437938ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:37.582826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.987915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:14:37.582827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.875692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:14:37.582887Z","caller":"traceutil/trace.go:171","msg":"trace[1276807397] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:4647; }","duration":"105.093037ms","start":"2026-04-21T17:14:37.477762Z","end":"2026-04-21T17:14:37.582855Z","steps":["trace[1276807397] 'agreement among raft nodes before linearized reading' (duration: 104.857124ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:37.583347Z","caller":"traceutil/trace.go:171","msg":"trace[1817051569] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:4647; }","duration":"163.015055ms","start":"2026-04-21T17:14:37.419885Z","end":"2026-04-21T17:14:37.5829Z","steps":["trace[1817051569] 'agreement among raft nodes before linearized reading' (duration: 162.732731ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:44.444925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.528215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T17:14:44.445006Z","caller":"traceutil/trace.go:171","msg":"trace[1901473681] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:4809; }","duration":"193.664587ms","start":"2026-04-21T17:14:44.251324Z","end":"2026-04-21T17:14:44.444988Z","steps":["trace[1901473681] 'count revisions from in-memory index tree' (duration: 193.398553ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:44.445318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.515691ms","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-21T17:14:44.445397Z","caller":"traceutil/trace.go:171","msg":"trace[1148041922] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4809; }","duration":"159.649602ms","start":"2026-04-21T17:14:44.285728Z","end":"2026-04-21T17:14:44.445378Z","steps":["trace[1148041922] 'range keys from in-memory index tree' (duration: 159.302738ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:16:27.11354Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2928} {"level":"info","ts":"2026-04-21T17:16:27.239641Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2928,"took":"124.798587ms","hash":1807902386,"current-db-size-bytes":53903360,"current-db-size":"54 MB","current-db-size-in-use-bytes":29454336,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-21T17:16:27.239693Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1807902386,"revision":2928,"compact-revision":-1} {"level":"info","ts":"2026-04-21T17:18:56.356457Z","caller":"traceutil/trace.go:171","msg":"trace[1932845966] transaction","detail":"{read_only:false; response_revision:6657; number_of_response:1; }","duration":"107.317642ms","start":"2026-04-21T17:18:56.249113Z","end":"2026-04-21T17:18:56.356431Z","steps":["trace[1932845966] 'process raft request' (duration: 67.157837ms)","trace[1932845966] 'compare' (duration: 39.04497ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:21:27.119914Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5647} {"level":"info","ts":"2026-04-21T17:21:27.194837Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5647,"took":"73.389751ms","hash":3744859427,"current-db-size-bytes":53903360,"current-db-size":"54 MB","current-db-size-in-use-bytes":18178048,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-21T17:21:27.194902Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3744859427,"revision":5647,"compact-revision":2928}