{"level":"warn","ts":"2026-05-05T10:20:13.346388Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T10:20:13.346567Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.20: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.20:2380","--initial-cluster=instance=https://199.19.213.20:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.20:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.20: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-05-05T10:20:13.346666Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T10:20:13.34669Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.20:2380"]} {"level":"info","ts":"2026-05-05T10:20:13.346718Z","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-05-05T10:20:13.347598Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.20:2379"]} {"level":"info","ts":"2026-05-05T10:20:13.347709Z","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.20:2380"],"listen-peer-urls":["https://199.19.213.20:2380"],"advertise-client-urls":["https://199.19.213.20:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.20:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.20: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-05-05T10:20:13.352391Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.385345ms"} {"level":"info","ts":"2026-05-05T10:20:13.359811Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"185293d8d40ffce0","cluster-id":"cc857afa6e1fa648"} {"level":"info","ts":"2026-05-05T10:20:13.359924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 switched to configuration voters=()"} {"level":"info","ts":"2026-05-05T10:20:13.35998Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became follower at term 0"} {"level":"info","ts":"2026-05-05T10:20:13.360007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 185293d8d40ffce0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-05T10:20:13.360035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became follower at term 1"} {"level":"info","ts":"2026-05-05T10:20:13.360105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 switched to configuration voters=(1752625764480580832)"} {"level":"warn","ts":"2026-05-05T10:20:13.36645Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-05T10:20:13.370945Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-05T10:20:13.373903Z","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-05-05T10:20:13.377217Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"185293d8d40ffce0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-05T10:20:13.377392Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"185293d8d40ffce0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-05T10:20:13.377413Z","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-05-05T10:20:13.377639Z","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-05-05T10:20:13.377682Z","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-05-05T10:20:13.379131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 switched to configuration voters=(1752625764480580832)"} {"level":"info","ts":"2026-05-05T10:20:13.379289Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cc857afa6e1fa648","local-member-id":"185293d8d40ffce0","added-peer-id":"185293d8d40ffce0","added-peer-peer-urls":["https://199.19.213.20:2380"]} {"level":"info","ts":"2026-05-05T10:20:13.380628Z","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-05-05T10:20:13.380728Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.20:2380"} {"level":"info","ts":"2026-05-05T10:20:13.380771Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.20:2380"} {"level":"info","ts":"2026-05-05T10:20:13.380873Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"185293d8d40ffce0","initial-advertise-peer-urls":["https://199.19.213.20:2380"],"listen-peer-urls":["https://199.19.213.20:2380"],"advertise-client-urls":["https://199.19.213.20:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.20:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-05T10:20:13.380913Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-05T10:20:14.161035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 is starting a new election at term 1"} {"level":"info","ts":"2026-05-05T10:20:14.161096Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-05T10:20:14.161136Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 received MsgPreVoteResp from 185293d8d40ffce0 at term 1"} {"level":"info","ts":"2026-05-05T10:20:14.161166Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became candidate at term 2"} {"level":"info","ts":"2026-05-05T10:20:14.161177Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 received MsgVoteResp from 185293d8d40ffce0 at term 2"} {"level":"info","ts":"2026-05-05T10:20:14.161195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became leader at term 2"} {"level":"info","ts":"2026-05-05T10:20:14.161209Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 185293d8d40ffce0 elected leader 185293d8d40ffce0 at term 2"} {"level":"info","ts":"2026-05-05T10:20:14.16255Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T10:20:14.163459Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T10:20:14.163449Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"185293d8d40ffce0","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.20:2379]}","request-path":"/0/members/185293d8d40ffce0/attributes","cluster-id":"cc857afa6e1fa648","publish-timeout":"7s"} {"level":"info","ts":"2026-05-05T10:20:14.163511Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T10:20:14.16388Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-05T10:20:14.16394Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-05T10:20:14.164086Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cc857afa6e1fa648","local-member-id":"185293d8d40ffce0","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T10:20:14.16423Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T10:20:14.164275Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T10:20:14.167768Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-05T10:20:14.167786Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.20:2379"} {"level":"warn","ts":"2026-05-05T10:20:34.265787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.35502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-05T10:20:34.265965Z","caller":"traceutil/trace.go:171","msg":"trace[1441019870] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:456; }","duration":"149.613104ms","start":"2026-05-05T10:20:34.116324Z","end":"2026-05-05T10:20:34.265937Z","steps":["trace[1441019870] 'range keys from in-memory index tree' (duration: 149.092245ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:44.937825Z","caller":"traceutil/trace.go:171","msg":"trace[1963636539] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"130.91382ms","start":"2026-05-05T10:20:44.806888Z","end":"2026-05-05T10:20:44.937802Z","steps":["trace[1963636539] 'process raft request' (duration: 130.763488ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:44.945541Z","caller":"traceutil/trace.go:171","msg":"trace[742219181] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"121.660802ms","start":"2026-05-05T10:20:44.823845Z","end":"2026-05-05T10:20:44.945506Z","steps":["trace[742219181] 'process raft request' (duration: 121.339475ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:44.94576Z","caller":"traceutil/trace.go:171","msg":"trace[2071505127] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"121.57004ms","start":"2026-05-05T10:20:44.824125Z","end":"2026-05-05T10:20:44.945695Z","steps":["trace[2071505127] 'process raft request' (duration: 121.267274ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:44.945856Z","caller":"traceutil/trace.go:171","msg":"trace[979166171] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"106.64526ms","start":"2026-05-05T10:20:44.839176Z","end":"2026-05-05T10:20:44.945821Z","steps":["trace[979166171] 'process raft request' (duration: 106.364355ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:44.94594Z","caller":"traceutil/trace.go:171","msg":"trace[1886664353] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"106.65032ms","start":"2026-05-05T10:20:44.839262Z","end":"2026-05-05T10:20:44.945912Z","steps":["trace[1886664353] 'process raft request' (duration: 106.490707ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:44.94609Z","caller":"traceutil/trace.go:171","msg":"trace[931160826] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"105.680441ms","start":"2026-05-05T10:20:44.840398Z","end":"2026-05-05T10:20:44.946078Z","steps":["trace[931160826] 'process raft request' (duration: 105.489318ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:44.94618Z","caller":"traceutil/trace.go:171","msg":"trace[328494020] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"105.346775ms","start":"2026-05-05T10:20:44.840825Z","end":"2026-05-05T10:20:44.946171Z","steps":["trace[328494020] 'process raft request' (duration: 105.131421ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:44.946389Z","caller":"traceutil/trace.go:171","msg":"trace[1509638493] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"105.270944ms","start":"2026-05-05T10:20:44.841099Z","end":"2026-05-05T10:20:44.94637Z","steps":["trace[1509638493] 'process raft request' (duration: 104.924547ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:51.217723Z","caller":"traceutil/trace.go:171","msg":"trace[1402180916] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"177.454154ms","start":"2026-05-05T10:20:51.040235Z","end":"2026-05-05T10:20:51.217689Z","steps":["trace[1402180916] 'process raft request' (duration: 176.670999ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:51.91186Z","caller":"traceutil/trace.go:171","msg":"trace[1164897608] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"127.21278ms","start":"2026-05-05T10:20:51.784611Z","end":"2026-05-05T10:20:51.911824Z","steps":["trace[1164897608] 'process raft request' (duration: 125.709091ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:12.528092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.831424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2kxxt\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-05-05T10:21:12.528193Z","caller":"traceutil/trace.go:171","msg":"trace[277010056] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2kxxt; range_end:; response_count:1; response_revision:803; }","duration":"136.987427ms","start":"2026-05-05T10:21:12.391182Z","end":"2026-05-05T10:21:12.52817Z","steps":["trace[277010056] 'range keys from in-memory index tree' (duration: 136.65554ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:22:03.815926Z","caller":"traceutil/trace.go:171","msg":"trace[1976123026] transaction","detail":"{read_only:false; response_revision:1460; number_of_response:1; }","duration":"100.850602ms","start":"2026-05-05T10:22:03.715048Z","end":"2026-05-05T10:22:03.815898Z","steps":["trace[1976123026] 'process raft request' (duration: 100.674699ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:22:31.271541Z","caller":"traceutil/trace.go:171","msg":"trace[1472225991] linearizableReadLoop","detail":"{readStateIndex:1962; appliedIndex:1961; }","duration":"183.918065ms","start":"2026-05-05T10:22:31.087578Z","end":"2026-05-05T10:22:31.271496Z","steps":["trace[1472225991] 'read index received' (duration: 183.70157ms)","trace[1472225991] 'applied index is now lower than readState.Index' (duration: 215.465µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:22:31.271627Z","caller":"traceutil/trace.go:171","msg":"trace[1668734734] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"272.211877ms","start":"2026-05-05T10:22:30.999385Z","end":"2026-05-05T10:22:31.271597Z","steps":["trace[1668734734] 'process raft request' (duration: 271.960812ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:22:31.271782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.302486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5fc61627-deec-4e5f-abb8-88a1d86df7f4\" ","response":"range_response_count:1 size:3626"} {"level":"warn","ts":"2026-05-05T10:22:31.271744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.136838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:22:31.271833Z","caller":"traceutil/trace.go:171","msg":"trace[1897708225] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5fc61627-deec-4e5f-abb8-88a1d86df7f4; range_end:; response_count:1; response_revision:1890; }","duration":"182.406138ms","start":"2026-05-05T10:22:31.089411Z","end":"2026-05-05T10:22:31.271817Z","steps":["trace[1897708225] 'agreement among raft nodes before linearized reading' (duration: 182.241945ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:22:31.271863Z","caller":"traceutil/trace.go:171","msg":"trace[2000616413] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1890; }","duration":"184.317961ms","start":"2026-05-05T10:22:31.087517Z","end":"2026-05-05T10:22:31.271835Z","steps":["trace[2000616413] 'agreement among raft nodes before linearized reading' (duration: 184.116748ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:22:31.271953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.872905ms","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-05-05T10:22:31.272042Z","caller":"traceutil/trace.go:171","msg":"trace[1968048443] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1890; }","duration":"144.013636ms","start":"2026-05-05T10:22:31.12801Z","end":"2026-05-05T10:22:31.272024Z","steps":["trace[1968048443] 'agreement among raft nodes before linearized reading' (duration: 143.769132ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:23:21.37002Z","caller":"traceutil/trace.go:171","msg":"trace[1478039977] transaction","detail":"{read_only:false; response_revision:2210; number_of_response:1; }","duration":"120.328081ms","start":"2026-05-05T10:23:21.248931Z","end":"2026-05-05T10:23:21.36926Z","steps":["trace[1478039977] 'process raft request' (duration: 120.015456ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:23:22.170143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.807828ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T10:23:22.17036Z","caller":"traceutil/trace.go:171","msg":"trace[1479028565] linearizableReadLoop","detail":"{readStateIndex:2298; appliedIndex:2297; }","duration":"259.433535ms","start":"2026-05-05T10:23:21.910886Z","end":"2026-05-05T10:23:22.170319Z","steps":["trace[1479028565] 'read index received' (duration: 97.022177ms)","trace[1479028565] 'applied index is now lower than readState.Index' (duration: 162.409508ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:23:22.170438Z","caller":"traceutil/trace.go:171","msg":"trace[863972689] transaction","detail":"{read_only:false; response_revision:2215; number_of_response:1; }","duration":"370.939826ms","start":"2026-05-05T10:23:21.79943Z","end":"2026-05-05T10:23:22.17037Z","steps":["trace[863972689] 'process raft request' (duration: 208.634241ms)","trace[863972689] 'compare' (duration: 160.558413ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:23:22.170682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.794053ms","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-05-05T10:23:22.17078Z","caller":"traceutil/trace.go:171","msg":"trace[1492190993] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2215; }","duration":"259.925695ms","start":"2026-05-05T10:23:21.91082Z","end":"2026-05-05T10:23:22.170746Z","steps":["trace[1492190993] 'agreement among raft nodes before linearized reading' (duration: 259.61675ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:23:22.170662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:23:21.799398Z","time spent":"371.150041ms","remote":"127.0.0.1:57172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T10:23:22.341727Z","caller":"traceutil/trace.go:171","msg":"trace[588071894] linearizableReadLoop","detail":"{readStateIndex:2299; appliedIndex:2298; }","duration":"171.30017ms","start":"2026-05-05T10:23:22.170391Z","end":"2026-05-05T10:23:22.341692Z","steps":["trace[588071894] 'read index received' (duration: 134.926138ms)","trace[588071894] 'applied index is now lower than readState.Index' (duration: 36.372682ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:23:22.341814Z","caller":"traceutil/trace.go:171","msg":"trace[1458220921] transaction","detail":"{read_only:false; response_revision:2216; number_of_response:1; }","duration":"231.1404ms","start":"2026-05-05T10:23:22.110617Z","end":"2026-05-05T10:23:22.341757Z","steps":["trace[1458220921] 'process raft request' (duration: 194.709336ms)","trace[1458220921] 'compare' (duration: 36.21591ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:23:22.341947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.977795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12385"} {"level":"warn","ts":"2026-05-05T10:23:22.341983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.918903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:23:22.342029Z","caller":"traceutil/trace.go:171","msg":"trace[824105655] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:2216; }","duration":"244.057515ms","start":"2026-05-05T10:23:22.097958Z","end":"2026-05-05T10:23:22.342016Z","steps":["trace[824105655] 'agreement among raft nodes before linearized reading' (duration: 243.937263ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:23:22.342019Z","caller":"traceutil/trace.go:171","msg":"trace[1874893577] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2216; }","duration":"238.080976ms","start":"2026-05-05T10:23:22.103918Z","end":"2026-05-05T10:23:22.341999Z","steps":["trace[1874893577] 'agreement among raft nodes before linearized reading' (duration: 237.842112ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:23:22.342193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.407551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-05T10:23:22.342234Z","caller":"traceutil/trace.go:171","msg":"trace[2044350222] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2216; }","duration":"255.503913ms","start":"2026-05-05T10:23:22.086721Z","end":"2026-05-05T10:23:22.342225Z","steps":["trace[2044350222] 'agreement among raft nodes before linearized reading' (duration: 255.389291ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:23:22.342209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.567714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:23:22.342312Z","caller":"traceutil/trace.go:171","msg":"trace[287810523] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2216; }","duration":"138.724066ms","start":"2026-05-05T10:23:22.203566Z","end":"2026-05-05T10:23:22.34229Z","steps":["trace[287810523] 'agreement among raft nodes before linearized reading' (duration: 138.549213ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:24:45.141015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.538975ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T10:24:45.141227Z","caller":"traceutil/trace.go:171","msg":"trace[69682325] transaction","detail":"{read_only:false; response_revision:2857; number_of_response:1; }","duration":"153.18332ms","start":"2026-05-05T10:24:44.988009Z","end":"2026-05-05T10:24:45.141192Z","steps":["trace[69682325] 'process raft request' (duration: 51.317548ms)","trace[69682325] 'compare' (duration: 101.343802ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:24:45.346477Z","caller":"traceutil/trace.go:171","msg":"trace[2112199636] linearizableReadLoop","detail":"{readStateIndex:2967; appliedIndex:2966; }","duration":"142.186168ms","start":"2026-05-05T10:24:45.204265Z","end":"2026-05-05T10:24:45.346451Z","steps":["trace[2112199636] 'read index received' (duration: 141.433565ms)","trace[2112199636] 'applied index is now lower than readState.Index' (duration: 751.763µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:24:45.346793Z","caller":"traceutil/trace.go:171","msg":"trace[875725740] transaction","detail":"{read_only:false; response_revision:2858; number_of_response:1; }","duration":"142.586366ms","start":"2026-05-05T10:24:45.204173Z","end":"2026-05-05T10:24:45.34676Z","steps":["trace[875725740] 'process raft request' (duration: 141.598518ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:24:45.346758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.466564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:24:45.346977Z","caller":"traceutil/trace.go:171","msg":"trace[45765463] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2858; }","duration":"142.745819ms","start":"2026-05-05T10:24:45.204206Z","end":"2026-05-05T10:24:45.346952Z","steps":["trace[45765463] 'agreement among raft nodes before linearized reading' (duration: 142.458023ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:28:46.658416Z","caller":"traceutil/trace.go:171","msg":"trace[103355896] transaction","detail":"{read_only:false; response_revision:5069; number_of_response:1; }","duration":"123.13971ms","start":"2026-05-05T10:28:46.535256Z","end":"2026-05-05T10:28:46.658396Z","steps":["trace[103355896] 'process raft request' (duration: 123.001818ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:28:46.690704Z","caller":"traceutil/trace.go:171","msg":"trace[782670] transaction","detail":"{read_only:false; response_revision:5070; number_of_response:1; }","duration":"155.382618ms","start":"2026-05-05T10:28:46.535294Z","end":"2026-05-05T10:28:46.690677Z","steps":["trace[782670] 'process raft request' (duration: 155.189035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:28:49.093537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.669419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:778246"} {"level":"info","ts":"2026-05-05T10:28:49.093629Z","caller":"traceutil/trace.go:171","msg":"trace[1546877999] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5114; }","duration":"168.816861ms","start":"2026-05-05T10:28:48.924792Z","end":"2026-05-05T10:28:49.093609Z","steps":["trace[1546877999] 'range keys from in-memory index tree' (duration: 168.16576ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:28:58.369112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.952644ms","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-05-05T10:28:58.369211Z","caller":"traceutil/trace.go:171","msg":"trace[257308917] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5298; }","duration":"109.099326ms","start":"2026-05-05T10:28:58.26009Z","end":"2026-05-05T10:28:58.369189Z","steps":["trace[257308917] 'agreement among raft nodes before linearized reading' (duration: 108.926223ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:29:06.448873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.738474ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T10:29:06.449156Z","caller":"traceutil/trace.go:171","msg":"trace[2022740271] transaction","detail":"{read_only:false; response_revision:5460; number_of_response:1; }","duration":"135.402562ms","start":"2026-05-05T10:29:06.313738Z","end":"2026-05-05T10:29:06.449141Z","steps":["trace[2022740271] 'process raft request' (duration: 135.354261ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:29:06.449171Z","caller":"traceutil/trace.go:171","msg":"trace[1935842746] linearizableReadLoop","detail":"{readStateIndex:5658; appliedIndex:5657; }","duration":"141.673051ms","start":"2026-05-05T10:29:06.307473Z","end":"2026-05-05T10:29:06.449146Z","steps":["trace[1935842746] 'read index received' (duration: 11.538139ms)","trace[1935842746] 'applied index is now lower than readState.Index' (duration: 130.133442ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:29:06.449304Z","caller":"traceutil/trace.go:171","msg":"trace[543431659] transaction","detail":"{read_only:false; response_revision:5458; number_of_response:1; }","duration":"169.519225ms","start":"2026-05-05T10:29:06.279772Z","end":"2026-05-05T10:29:06.449291Z","steps":["trace[543431659] 'process raft request' (duration: 39.28998ms)","trace[543431659] 'compare' (duration: 129.605412ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:29:06.449403Z","caller":"traceutil/trace.go:171","msg":"trace[207670029] transaction","detail":"{read_only:false; response_revision:5459; number_of_response:1; }","duration":"136.405331ms","start":"2026-05-05T10:29:06.312972Z","end":"2026-05-05T10:29:06.449377Z","steps":["trace[207670029] 'process raft request' (duration: 136.077514ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:29:06.449527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.957275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:29:06.449576Z","caller":"traceutil/trace.go:171","msg":"trace[115785886] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:5460; }","duration":"212.051457ms","start":"2026-05-05T10:29:06.237511Z","end":"2026-05-05T10:29:06.449563Z","steps":["trace[115785886] 'agreement among raft nodes before linearized reading' (duration: 211.948525ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:29:06.45005Z","caller":"traceutil/trace.go:171","msg":"trace[218336156] transaction","detail":"{read_only:false; response_revision:5461; number_of_response:1; }","duration":"126.038215ms","start":"2026-05-05T10:29:06.324Z","end":"2026-05-05T10:29:06.450038Z","steps":["trace[218336156] 'process raft request' (duration: 125.932813ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:29:06.451282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.177262ms","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-05-05T10:29:06.451336Z","caller":"traceutil/trace.go:171","msg":"trace[1289408541] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1; range_end:; response_count:0; response_revision:5462; }","duration":"140.232893ms","start":"2026-05-05T10:29:06.31109Z","end":"2026-05-05T10:29:06.451323Z","steps":["trace[1289408541] 'agreement among raft nodes before linearized reading' (duration: 140.136331ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:29:06.451545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.509718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1dfa6998-6c54-4d4b-9dc0-4a167d35f434\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-05-05T10:29:06.451638Z","caller":"traceutil/trace.go:171","msg":"trace[248792587] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1dfa6998-6c54-4d4b-9dc0-4a167d35f434; range_end:; response_count:1; response_revision:5462; }","duration":"114.655161ms","start":"2026-05-05T10:29:06.336962Z","end":"2026-05-05T10:29:06.451617Z","steps":["trace[248792587] 'agreement among raft nodes before linearized reading' (duration: 114.368396ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:29:06.671983Z","caller":"traceutil/trace.go:171","msg":"trace[1342770621] linearizableReadLoop","detail":"{readStateIndex:5664; appliedIndex:5663; }","duration":"128.96574ms","start":"2026-05-05T10:29:06.54299Z","end":"2026-05-05T10:29:06.671955Z","steps":["trace[1342770621] 'read index received' (duration: 92.802778ms)","trace[1342770621] 'applied index is now lower than readState.Index' (duration: 36.161732ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:29:06.672085Z","caller":"traceutil/trace.go:171","msg":"trace[1128369405] transaction","detail":"{read_only:false; response_revision:5464; number_of_response:1; }","duration":"129.927319ms","start":"2026-05-05T10:29:06.542126Z","end":"2026-05-05T10:29:06.672053Z","steps":["trace[1128369405] 'process raft request' (duration: 93.649265ms)","trace[1128369405] 'compare' (duration: 36.024279ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:29:06.672257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.246835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-05-05T10:29:06.672304Z","caller":"traceutil/trace.go:171","msg":"trace[1458904491] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:5464; }","duration":"129.336127ms","start":"2026-05-05T10:29:06.542953Z","end":"2026-05-05T10:29:06.672289Z","steps":["trace[1458904491] 'agreement among raft nodes before linearized reading' (duration: 129.138473ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:29:06.672449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.015669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3565"} {"level":"info","ts":"2026-05-05T10:29:06.672661Z","caller":"traceutil/trace.go:171","msg":"trace[864882544] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5464; }","duration":"106.324034ms","start":"2026-05-05T10:29:06.566313Z","end":"2026-05-05T10:29:06.672638Z","steps":["trace[864882544] 'agreement among raft nodes before linearized reading' (duration: 105.876706ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:29:07.069725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.322755ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T10:29:07.070157Z","caller":"traceutil/trace.go:171","msg":"trace[1861251105] transaction","detail":"{read_only:false; response_revision:5465; number_of_response:1; }","duration":"385.352422ms","start":"2026-05-05T10:29:06.684742Z","end":"2026-05-05T10:29:07.070095Z","steps":["trace[1861251105] 'process raft request' (duration: 201.570358ms)","trace[1861251105] 'compare' (duration: 183.070211ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:29:07.070369Z","caller":"traceutil/trace.go:171","msg":"trace[397497054] transaction","detail":"{read_only:false; number_of_response:1; response_revision:5465; }","duration":"385.362212ms","start":"2026-05-05T10:29:06.684972Z","end":"2026-05-05T10:29:07.070334Z","steps":["trace[397497054] 'process raft request' (duration: 384.897234ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:29:07.070464Z","caller":"traceutil/trace.go:171","msg":"trace[1687982404] linearizableReadLoop","detail":"{readStateIndex:5666; appliedIndex:5664; }","duration":"383.246752ms","start":"2026-05-05T10:29:06.687175Z","end":"2026-05-05T10:29:07.070421Z","steps":["trace[1687982404] 'read index received' (duration: 199.138862ms)","trace[1687982404] 'applied index is now lower than readState.Index' (duration: 184.10236ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:29:07.070513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:29:06.68472Z","time spent":"385.608987ms","remote":"127.0.0.1:32874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2263,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T10:29:07.070572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:29:06.684956Z","time spent":"385.507515ms","remote":"127.0.0.1:32874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":103,"response count":0,"response size":2312,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T10:29:07.070587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.390744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:29:07.070667Z","caller":"traceutil/trace.go:171","msg":"trace[1038448677] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1; range_end:; response_count:0; response_revision:5466; }","duration":"383.483137ms","start":"2026-05-05T10:29:06.68716Z","end":"2026-05-05T10:29:07.070643Z","steps":["trace[1038448677] 'agreement among raft nodes before linearized reading' (duration: 383.341844ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:29:07.070715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:29:06.687153Z","time spent":"383.553408ms","remote":"127.0.0.1:57016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1\" "} {"level":"info","ts":"2026-05-05T10:29:07.070382Z","caller":"traceutil/trace.go:171","msg":"trace[1514923956] transaction","detail":"{read_only:false; response_revision:5466; number_of_response:1; }","duration":"372.278625ms","start":"2026-05-05T10:29:06.698063Z","end":"2026-05-05T10:29:07.070342Z","steps":["trace[1514923956] 'process raft request' (duration: 372.134553ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:29:07.070871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.471219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-05T10:29:07.070921Z","caller":"traceutil/trace.go:171","msg":"trace[1425330507] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5466; }","duration":"321.53979ms","start":"2026-05-05T10:29:06.749372Z","end":"2026-05-05T10:29:07.070912Z","steps":["trace[1425330507] 'agreement among raft nodes before linearized reading' (duration: 321.374246ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:29:07.070965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:29:06.749361Z","time spent":"321.597952ms","remote":"127.0.0.1:57172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-05T10:29:07.070883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:29:06.69805Z","time spent":"372.760036ms","remote":"127.0.0.1:57172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T10:29:07.070954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.596583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-05T10:29:07.071059Z","caller":"traceutil/trace.go:171","msg":"trace[899391168] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5466; }","duration":"293.716426ms","start":"2026-05-05T10:29:06.777317Z","end":"2026-05-05T10:29:07.071033Z","steps":["trace[899391168] 'agreement among raft nodes before linearized reading' (duration: 293.42467ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:29:07.071172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.322011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4866"} {"level":"info","ts":"2026-05-05T10:29:07.071223Z","caller":"traceutil/trace.go:171","msg":"trace[238783674] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:5466; }","duration":"377.397993ms","start":"2026-05-05T10:29:06.693811Z","end":"2026-05-05T10:29:07.071209Z","steps":["trace[238783674] 'agreement among raft nodes before linearized reading' (duration: 377.278791ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:29:07.071264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:29:06.693804Z","time spent":"377.449904ms","remote":"127.0.0.1:41702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":4889,"request content":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" "} {"level":"warn","ts":"2026-05-05T10:29:07.071245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.579292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"} {"level":"info","ts":"2026-05-05T10:29:07.07141Z","caller":"traceutil/trace.go:171","msg":"trace[1475706408] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:5466; }","duration":"381.720004ms","start":"2026-05-05T10:29:06.689618Z","end":"2026-05-05T10:29:07.071338Z","steps":["trace[1475706408] 'agreement among raft nodes before linearized reading' (duration: 381.062441ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:29:07.071491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:29:06.689608Z","time spent":"381.870037ms","remote":"127.0.0.1:57016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":1,"response size":1154,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" "} {"level":"info","ts":"2026-05-05T10:30:14.190961Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3018} {"level":"info","ts":"2026-05-05T10:30:14.270112Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3018,"took":"77.172322ms","hash":3902056176,"current-db-size-bytes":57491456,"current-db-size":"58 MB","current-db-size-in-use-bytes":31547392,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-05T10:30:14.27018Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3902056176,"revision":3018,"compact-revision":-1} {"level":"info","ts":"2026-05-05T10:35:14.197503Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6100} {"level":"info","ts":"2026-05-05T10:35:14.302611Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6100,"took":"102.315124ms","hash":2256604338,"current-db-size-bytes":57491456,"current-db-size":"58 MB","current-db-size-in-use-bytes":21315584,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-05-05T10:35:14.302722Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2256604338,"revision":6100,"compact-revision":3018} {"level":"warn","ts":"2026-05-05T10:35:23.414393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.427456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:35:23.414488Z","caller":"traceutil/trace.go:171","msg":"trace[1140663200] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8360; }","duration":"212.553669ms","start":"2026-05-05T10:35:23.20191Z","end":"2026-05-05T10:35:23.414463Z","steps":["trace[1140663200] 'range keys from in-memory index tree' (duration: 212.331345ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:35:23.414385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.495082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-05T10:35:23.414674Z","caller":"traceutil/trace.go:171","msg":"trace[631071090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8360; }","duration":"150.833738ms","start":"2026-05-05T10:35:23.263796Z","end":"2026-05-05T10:35:23.41463Z","steps":["trace[631071090] 'range keys from in-memory index tree' (duration: 150.297228ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:35:23.414821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.838111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-05T10:35:23.414538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.893631ms","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-05-05T10:35:23.414877Z","caller":"traceutil/trace.go:171","msg":"trace[1231232681] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:8360; }","duration":"307.898632ms","start":"2026-05-05T10:35:23.106961Z","end":"2026-05-05T10:35:23.41486Z","steps":["trace[1231232681] 'count revisions from in-memory index tree' (duration: 307.73058ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:35:23.414885Z","caller":"traceutil/trace.go:171","msg":"trace[1900841178] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8360; }","duration":"258.297898ms","start":"2026-05-05T10:35:23.15657Z","end":"2026-05-05T10:35:23.414868Z","steps":["trace[1900841178] 'range keys from in-memory index tree' (duration: 257.644037ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:35:23.414924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:35:23.106885Z","time spent":"308.022805ms","remote":"127.0.0.1:53314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":5,"response size":30,"request content":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true "} {"level":"info","ts":"2026-05-05T10:35:34.16165Z","caller":"traceutil/trace.go:171","msg":"trace[1611813306] transaction","detail":"{read_only:false; response_revision:8420; number_of_response:1; }","duration":"119.338625ms","start":"2026-05-05T10:35:34.042289Z","end":"2026-05-05T10:35:34.161628Z","steps":["trace[1611813306] 'process raft request' (duration: 119.187222ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:35:35.670696Z","caller":"traceutil/trace.go:171","msg":"trace[1678059534] linearizableReadLoop","detail":"{readStateIndex:8720; appliedIndex:8719; }","duration":"147.78674ms","start":"2026-05-05T10:35:35.522883Z","end":"2026-05-05T10:35:35.67067Z","steps":["trace[1678059534] 'read index received' (duration: 147.528395ms)","trace[1678059534] 'applied index is now lower than readState.Index' (duration: 257.115µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:35:35.67086Z","caller":"traceutil/trace.go:171","msg":"trace[433465564] transaction","detail":"{read_only:false; response_revision:8424; number_of_response:1; }","duration":"148.754589ms","start":"2026-05-05T10:35:35.522093Z","end":"2026-05-05T10:35:35.670847Z","steps":["trace[433465564] 'process raft request' (duration: 148.400302ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:35:35.671114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.227989ms","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-05-05T10:35:35.671146Z","caller":"traceutil/trace.go:171","msg":"trace[1053083627] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8424; }","duration":"148.32343ms","start":"2026-05-05T10:35:35.522815Z","end":"2026-05-05T10:35:35.671138Z","steps":["trace[1053083627] 'agreement among raft nodes before linearized reading' (duration: 148.178108ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:35:35.671246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.168133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-05-05T10:35:35.671204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.920133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T10:35:35.671268Z","caller":"traceutil/trace.go:171","msg":"trace[551139004] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8424; }","duration":"143.253545ms","start":"2026-05-05T10:35:35.528009Z","end":"2026-05-05T10:35:35.671262Z","steps":["trace[551139004] 'agreement among raft nodes before linearized reading' (duration: 143.194444ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:35:35.671303Z","caller":"traceutil/trace.go:171","msg":"trace[1453279407] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:8424; }","duration":"140.190117ms","start":"2026-05-05T10:35:35.531094Z","end":"2026-05-05T10:35:35.671284Z","steps":["trace[1453279407] 'agreement among raft nodes before linearized reading' (duration: 140.005954ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:35:35.671294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.346496ms","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-05-05T10:35:35.671385Z","caller":"traceutil/trace.go:171","msg":"trace[839104177] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8424; }","duration":"143.470269ms","start":"2026-05-05T10:35:35.527886Z","end":"2026-05-05T10:35:35.671356Z","steps":["trace[839104177] 'agreement among raft nodes before linearized reading' (duration: 143.215625ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:35:35.820171Z","caller":"traceutil/trace.go:171","msg":"trace[1242691411] transaction","detail":"{read_only:false; response_revision:8426; number_of_response:1; }","duration":"142.722214ms","start":"2026-05-05T10:35:35.677395Z","end":"2026-05-05T10:35:35.820117Z","steps":["trace[1242691411] 'process raft request' (duration: 142.430649ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:35:35.820212Z","caller":"traceutil/trace.go:171","msg":"trace[1992933392] transaction","detail":"{read_only:false; response_revision:8427; number_of_response:1; }","duration":"141.597203ms","start":"2026-05-05T10:35:35.678561Z","end":"2026-05-05T10:35:35.820159Z","steps":["trace[1992933392] 'process raft request' (duration: 141.467211ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:35:36.809053Z","caller":"traceutil/trace.go:171","msg":"trace[366939414] transaction","detail":"{read_only:false; response_revision:8431; number_of_response:1; }","duration":"100.359168ms","start":"2026-05-05T10:35:36.708652Z","end":"2026-05-05T10:35:36.809011Z","steps":["trace[366939414] 'process raft request' (duration: 100.105893ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:35:36.820013Z","caller":"traceutil/trace.go:171","msg":"trace[1867464495] transaction","detail":"{read_only:false; response_revision:8432; number_of_response:1; }","duration":"106.135936ms","start":"2026-05-05T10:35:36.713848Z","end":"2026-05-05T10:35:36.819984Z","steps":["trace[1867464495] 'process raft request' (duration: 105.943213ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:35:37.151252Z","caller":"traceutil/trace.go:171","msg":"trace[138738574] transaction","detail":"{read_only:false; response_revision:8433; number_of_response:1; }","duration":"136.936427ms","start":"2026-05-05T10:35:37.014281Z","end":"2026-05-05T10:35:37.151218Z","steps":["trace[138738574] 'process raft request' (duration: 136.725913ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:36:08.171277Z","caller":"traceutil/trace.go:171","msg":"trace[1285928648] linearizableReadLoop","detail":"{readStateIndex:8959; appliedIndex:8958; }","duration":"178.241803ms","start":"2026-05-05T10:36:07.993003Z","end":"2026-05-05T10:36:08.171245Z","steps":["trace[1285928648] 'read index received' (duration: 129.471895ms)","trace[1285928648] 'applied index is now lower than readState.Index' (duration: 48.768628ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:36:08.171317Z","caller":"traceutil/trace.go:171","msg":"trace[1326428574] transaction","detail":"{read_only:false; response_revision:8653; number_of_response:1; }","duration":"250.051154ms","start":"2026-05-05T10:36:07.921218Z","end":"2026-05-05T10:36:08.17127Z","steps":["trace[1326428574] 'process raft request' (duration: 201.241276ms)","trace[1326428574] 'compare' (duration: 48.634275ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:36:08.17165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.577739ms","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-05-05T10:36:08.171744Z","caller":"traceutil/trace.go:171","msg":"trace[1796854794] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8653; }","duration":"178.784383ms","start":"2026-05-05T10:36:07.99294Z","end":"2026-05-05T10:36:08.171724Z","steps":["trace[1796854794] 'agreement among raft nodes before linearized reading' (duration: 178.462837ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:36:08.210051Z","caller":"traceutil/trace.go:171","msg":"trace[98618049] transaction","detail":"{read_only:false; response_revision:8655; number_of_response:1; }","duration":"162.725962ms","start":"2026-05-05T10:36:08.047291Z","end":"2026-05-05T10:36:08.210017Z","steps":["trace[98618049] 'process raft request' (duration: 162.65047ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:36:08.210328Z","caller":"traceutil/trace.go:171","msg":"trace[462199605] transaction","detail":"{read_only:false; response_revision:8654; number_of_response:1; }","duration":"175.049703ms","start":"2026-05-05T10:36:08.035223Z","end":"2026-05-05T10:36:08.210273Z","steps":["trace[462199605] 'process raft request' (duration: 174.469932ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:36:08.225492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.417166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-05-05T10:36:08.225535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.125714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T10:36:08.225583Z","caller":"traceutil/trace.go:171","msg":"trace[213905407] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8657; }","duration":"229.592049ms","start":"2026-05-05T10:36:07.995969Z","end":"2026-05-05T10:36:08.225561Z","steps":["trace[213905407] 'agreement among raft nodes before linearized reading' (duration: 229.271733ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:36:08.22559Z","caller":"traceutil/trace.go:171","msg":"trace[1140732846] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:8657; }","duration":"218.228505ms","start":"2026-05-05T10:36:08.007348Z","end":"2026-05-05T10:36:08.225577Z","steps":["trace[1140732846] 'agreement among raft nodes before linearized reading' (duration: 218.108053ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:36:17.51765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.489837ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T10:36:17.518002Z","caller":"traceutil/trace.go:171","msg":"trace[665434208] linearizableReadLoop","detail":"{readStateIndex:9056; appliedIndex:9054; }","duration":"133.844298ms","start":"2026-05-05T10:36:17.384137Z","end":"2026-05-05T10:36:17.517981Z","steps":["trace[665434208] 'read index received' (duration: 29.999244ms)","trace[665434208] 'applied index is now lower than readState.Index' (duration: 103.843614ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:36:17.518152Z","caller":"traceutil/trace.go:171","msg":"trace[211779240] transaction","detail":"{read_only:false; response_revision:8745; number_of_response:1; }","duration":"201.179115ms","start":"2026-05-05T10:36:17.316937Z","end":"2026-05-05T10:36:17.518116Z","steps":["trace[211779240] 'process raft request' (duration: 200.957521ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:36:17.5182Z","caller":"traceutil/trace.go:171","msg":"trace[799788807] transaction","detail":"{read_only:false; response_revision:8744; number_of_response:1; }","duration":"202.896657ms","start":"2026-05-05T10:36:17.315256Z","end":"2026-05-05T10:36:17.518153Z","steps":["trace[799788807] 'process raft request' (duration: 98.797878ms)","trace[799788807] 'compare' (duration: 103.320494ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:36:17.518229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.085113ms","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-05-05T10:36:17.51848Z","caller":"traceutil/trace.go:171","msg":"trace[1072076405] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8745; }","duration":"134.377358ms","start":"2026-05-05T10:36:17.384089Z","end":"2026-05-05T10:36:17.518466Z","steps":["trace[1072076405] 'agreement among raft nodes before linearized reading' (duration: 134.009951ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:36:18.502379Z","caller":"traceutil/trace.go:171","msg":"trace[126660430] linearizableReadLoop","detail":"{readStateIndex:9066; appliedIndex:9064; }","duration":"144.337405ms","start":"2026-05-05T10:36:18.358008Z","end":"2026-05-05T10:36:18.502345Z","steps":["trace[126660430] 'read index received' (duration: 29.896462ms)","trace[126660430] 'applied index is now lower than readState.Index' (duration: 114.439623ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:36:18.502471Z","caller":"traceutil/trace.go:171","msg":"trace[1354879925] transaction","detail":"{read_only:false; response_revision:8755; number_of_response:1; }","duration":"144.671012ms","start":"2026-05-05T10:36:18.35775Z","end":"2026-05-05T10:36:18.502421Z","steps":["trace[1354879925] 'process raft request' (duration: 61.449956ms)","trace[1354879925] 'compare' (duration: 82.980772ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:36:18.502818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.750283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-05-05T10:36:18.502911Z","caller":"traceutil/trace.go:171","msg":"trace[843593836] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:8755; }","duration":"144.931155ms","start":"2026-05-05T10:36:18.357958Z","end":"2026-05-05T10:36:18.502889Z","steps":["trace[843593836] 'agreement among raft nodes before linearized reading' (duration: 144.520848ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:36:40.907253Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002470.wal"} {"level":"info","ts":"2026-05-05T10:37:56.461391Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"185293d8d40ffce0","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-05T10:37:56.468732Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-05-05T10:37:56.468816Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-05-05T10:40:14.207783Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8176} {"level":"info","ts":"2026-05-05T10:40:14.284142Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8176,"took":"73.753791ms","hash":2855472596,"current-db-size-bytes":57491456,"current-db-size":"58 MB","current-db-size-in-use-bytes":29650944,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-05T10:40:14.284215Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2855472596,"revision":8176,"compact-revision":6100} {"level":"warn","ts":"2026-05-05T10:41:18.037995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.906989ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T10:41:18.038161Z","caller":"traceutil/trace.go:171","msg":"trace[1332284640] transaction","detail":"{read_only:false; response_revision:11348; number_of_response:1; }","duration":"130.449192ms","start":"2026-05-05T10:41:17.907688Z","end":"2026-05-05T10:41:18.038137Z","steps":["trace[1332284640] 'process raft request' (duration: 29.293928ms)","trace[1332284640] 'compare' (duration: 100.697685ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:45:14.214449Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10788} {"level":"info","ts":"2026-05-05T10:45:14.302967Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10788,"took":"86.218566ms","hash":3559097821,"current-db-size-bytes":57491456,"current-db-size":"58 MB","current-db-size-in-use-bytes":27258880,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-05-05T10:45:14.303025Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3559097821,"revision":10788,"compact-revision":8176} {"level":"info","ts":"2026-05-05T10:50:14.221183Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12877} {"level":"info","ts":"2026-05-05T10:50:14.298665Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12877,"took":"74.370873ms","hash":1584426048,"current-db-size-bytes":57491456,"current-db-size":"58 MB","current-db-size-in-use-bytes":24743936,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-05-05T10:50:14.298728Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1584426048,"revision":12877,"compact-revision":10788} {"level":"info","ts":"2026-05-05T10:55:14.227415Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14689} {"level":"info","ts":"2026-05-05T10:55:14.303492Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14689,"took":"72.923543ms","hash":632727528,"current-db-size-bytes":57491456,"current-db-size":"58 MB","current-db-size-in-use-bytes":21069824,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-05-05T10:55:14.303563Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":632727528,"revision":14689,"compact-revision":12877} {"level":"info","ts":"2026-05-05T11:00:14.233352Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16212} {"level":"info","ts":"2026-05-05T11:00:14.295718Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16212,"took":"60.542708ms","hash":1068704036,"current-db-size-bytes":57491456,"current-db-size":"58 MB","current-db-size-in-use-bytes":20541440,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-05-05T11:00:14.2958Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1068704036,"revision":16212,"compact-revision":14689} {"level":"info","ts":"2026-05-05T11:05:14.244352Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17737} {"level":"info","ts":"2026-05-05T11:05:14.314555Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17737,"took":"66.551841ms","hash":908418780,"current-db-size-bytes":57491456,"current-db-size":"58 MB","current-db-size-in-use-bytes":20697088,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-05-05T11:05:14.314637Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":908418780,"revision":17737,"compact-revision":16212} {"level":"info","ts":"2026-05-05T11:05:16.916404Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"185293d8d40ffce0","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-05T11:05:16.922385Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-05-05T11:05:16.9225Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}