{"level":"warn","ts":"2026-04-07T12:56:35.066344Z","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-07T12:56:35.06644Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.115:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.115:2380","--initial-cluster=instance=https://199.204.45.115:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.115:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.115: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-07T12:56:35.066513Z","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-07T12:56:35.06653Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-04-07T12:56:35.06656Z","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-07T12:56:35.067438Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"]} {"level":"info","ts":"2026-04-07T12:56:35.067536Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.115: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-07T12:56:35.071522Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.720019ms"} {"level":"info","ts":"2026-04-07T12:56:35.080269Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e3aaa5c123e150e0","cluster-id":"61ec519698823541"} {"level":"info","ts":"2026-04-07T12:56:35.080409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T12:56:35.08044Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 0"} {"level":"info","ts":"2026-04-07T12:56:35.080456Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e3aaa5c123e150e0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T12:56:35.080471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 1"} {"level":"info","ts":"2026-04-07T12:56:35.080519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"warn","ts":"2026-04-07T12:56:35.093384Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T12:56:35.095541Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T12:56:35.096659Z","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-07T12:56:35.098525Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e3aaa5c123e150e0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T12:56:35.098704Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e3aaa5c123e150e0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T12:56:35.098986Z","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-07T12:56:35.099097Z","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-07T12:56:35.099118Z","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-07T12:56:35.101406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"info","ts":"2026-04-07T12:56:35.101714Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","added-peer-id":"e3aaa5c123e150e0","added-peer-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-04-07T12:56:35.103614Z","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-07T12:56:35.103742Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-04-07T12:56:35.103863Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-04-07T12:56:35.103896Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e3aaa5c123e150e0","initial-advertise-peer-urls":["https://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T12:56:35.103931Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T12:56:35.181139Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T12:56:35.18121Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T12:56:35.181235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgPreVoteResp from e3aaa5c123e150e0 at term 1"} {"level":"info","ts":"2026-04-07T12:56:35.181259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became candidate at term 2"} {"level":"info","ts":"2026-04-07T12:56:35.181434Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgVoteResp from e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-04-07T12:56:35.181467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became leader at term 2"} {"level":"info","ts":"2026-04-07T12:56:35.181665Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e3aaa5c123e150e0 elected leader e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-04-07T12:56:35.182802Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T12:56:35.183599Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e3aaa5c123e150e0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.115:2379]}","request-path":"/0/members/e3aaa5c123e150e0/attributes","cluster-id":"61ec519698823541","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T12:56:35.183609Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T12:56:35.18365Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T12:56:35.184035Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T12:56:35.184063Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T12:56:35.184224Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T12:56:35.184419Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T12:56:35.184475Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T12:56:35.185687Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T12:56:35.187535Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.115:2379"} {"level":"info","ts":"2026-04-07T12:56:57.990774Z","caller":"traceutil/trace.go:171","msg":"trace[407121593] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"113.958012ms","start":"2026-04-07T12:56:57.876788Z","end":"2026-04-07T12:56:57.990746Z","steps":["trace[407121593] 'process raft request' (duration: 113.827449ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:57:06.177128Z","caller":"traceutil/trace.go:171","msg":"trace[866232440] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"193.918716ms","start":"2026-04-07T12:57:05.983182Z","end":"2026-04-07T12:57:06.177101Z","steps":["trace[866232440] 'process raft request' (duration: 191.45183ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:57:06.177142Z","caller":"traceutil/trace.go:171","msg":"trace[703727760] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"185.271905ms","start":"2026-04-07T12:57:05.991845Z","end":"2026-04-07T12:57:06.177117Z","steps":["trace[703727760] 'process raft request' (duration: 185.148962ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:57:06.177429Z","caller":"traceutil/trace.go:171","msg":"trace[168916770] linearizableReadLoop","detail":"{readStateIndex:516; appliedIndex:512; }","duration":"151.474975ms","start":"2026-04-07T12:57:06.025764Z","end":"2026-04-07T12:57:06.177239Z","steps":["trace[168916770] 'read index received' (duration: 23.963417ms)","trace[168916770] 'applied index is now lower than readState.Index' (duration: 127.510078ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T12:57:06.177588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.737379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-07T12:57:06.177795Z","caller":"traceutil/trace.go:171","msg":"trace[303883333] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:499; }","duration":"152.038664ms","start":"2026-04-07T12:57:06.02573Z","end":"2026-04-07T12:57:06.177769Z","steps":["trace[303883333] 'agreement among raft nodes before linearized reading' (duration: 151.604717ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:57:06.181846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.637118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-07T12:57:06.181953Z","caller":"traceutil/trace.go:171","msg":"trace[2099103932] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:502; }","duration":"107.78864ms","start":"2026-04-07T12:57:06.074142Z","end":"2026-04-07T12:57:06.18193Z","steps":["trace[2099103932] 'agreement among raft nodes before linearized reading' (duration: 107.611727ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:57:06.18237Z","caller":"traceutil/trace.go:171","msg":"trace[1271831507] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"120.404635ms","start":"2026-04-07T12:57:06.061945Z","end":"2026-04-07T12:57:06.18235Z","steps":["trace[1271831507] 'process raft request' (duration: 119.378806ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:57:06.905755Z","caller":"traceutil/trace.go:171","msg":"trace[1171251562] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"252.693611ms","start":"2026-04-07T12:57:06.652641Z","end":"2026-04-07T12:57:06.905335Z","steps":["trace[1171251562] 'process raft request' (duration: 234.758446ms)","trace[1171251562] 'compare' (duration: 17.637359ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:57:06.910513Z","caller":"traceutil/trace.go:171","msg":"trace[689702130] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"103.030101ms","start":"2026-04-07T12:57:06.807456Z","end":"2026-04-07T12:57:06.910487Z","steps":["trace[689702130] 'process raft request' (duration: 102.564822ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:57:12.196482Z","caller":"traceutil/trace.go:171","msg":"trace[1958228597] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"118.52723ms","start":"2026-04-07T12:57:12.07793Z","end":"2026-04-07T12:57:12.196457Z","steps":["trace[1958228597] 'process raft request' (duration: 117.9569ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:57:12.451581Z","caller":"traceutil/trace.go:171","msg":"trace[467474506] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:598; }","duration":"137.716028ms","start":"2026-04-07T12:57:12.313835Z","end":"2026-04-07T12:57:12.451551Z","steps":["trace[467474506] 'read index received' (duration: 127.142121ms)","trace[467474506] 'applied index is now lower than readState.Index' (duration: 10.572767ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:57:12.45167Z","caller":"traceutil/trace.go:171","msg":"trace[146895319] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"199.181844ms","start":"2026-04-07T12:57:12.252449Z","end":"2026-04-07T12:57:12.451631Z","steps":["trace[146895319] 'process raft request' (duration: 188.603918ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:57:12.451758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.890501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T12:57:12.45182Z","caller":"traceutil/trace.go:171","msg":"trace[699779231] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"138.029974ms","start":"2026-04-07T12:57:12.313772Z","end":"2026-04-07T12:57:12.451802Z","steps":["trace[699779231] 'agreement among raft nodes before linearized reading' (duration: 137.874841ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:57:27.683438Z","caller":"traceutil/trace.go:171","msg":"trace[4220385] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"175.657871ms","start":"2026-04-07T12:57:27.507747Z","end":"2026-04-07T12:57:27.683405Z","steps":["trace[4220385] 'process raft request' (duration: 175.466357ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:58:40.177234Z","caller":"traceutil/trace.go:171","msg":"trace[927676105] linearizableReadLoop","detail":"{readStateIndex:1847; appliedIndex:1846; }","duration":"105.639702ms","start":"2026-04-07T12:58:40.071555Z","end":"2026-04-07T12:58:40.177194Z","steps":["trace[927676105] 'read index received' (duration: 105.379047ms)","trace[927676105] 'applied index is now lower than readState.Index' (duration: 259.285µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:58:40.177344Z","caller":"traceutil/trace.go:171","msg":"trace[1757272812] transaction","detail":"{read_only:false; response_revision:1780; number_of_response:1; }","duration":"118.777342ms","start":"2026-04-07T12:58:40.058522Z","end":"2026-04-07T12:58:40.1773Z","steps":["trace[1757272812] 'process raft request' (duration: 118.446025ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:58:40.177473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.879117ms","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-07T12:58:40.17756Z","caller":"traceutil/trace.go:171","msg":"trace[1493199971] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1780; }","duration":"106.05601ms","start":"2026-04-07T12:58:40.071487Z","end":"2026-04-07T12:58:40.177543Z","steps":["trace[1493199971] 'agreement among raft nodes before linearized reading' (duration: 105.852027ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:58:40.691399Z","caller":"traceutil/trace.go:171","msg":"trace[455439024] linearizableReadLoop","detail":"{readStateIndex:1848; appliedIndex:1847; }","duration":"195.961383ms","start":"2026-04-07T12:58:40.495411Z","end":"2026-04-07T12:58:40.691373Z","steps":["trace[455439024] 'read index received' (duration: 195.81063ms)","trace[455439024] 'applied index is now lower than readState.Index' (duration: 149.753µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T12:58:40.691652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.227887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b8a1a7a6-e588-4b4b-a6fe-98ffff4b2fd7\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-07T12:58:40.691479Z","caller":"traceutil/trace.go:171","msg":"trace[2136855923] transaction","detail":"{read_only:false; response_revision:1781; number_of_response:1; }","duration":"229.763646ms","start":"2026-04-07T12:58:40.461672Z","end":"2026-04-07T12:58:40.691436Z","steps":["trace[2136855923] 'process raft request' (duration: 229.543352ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:58:40.691773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.566357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b8a1a7a6-e588-4b4b-a6fe-98ffff4b2fd7\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-07T12:58:40.691879Z","caller":"traceutil/trace.go:171","msg":"trace[1238774115] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b8a1a7a6-e588-4b4b-a6fe-98ffff4b2fd7; range_end:; response_count:1; response_revision:1781; }","duration":"141.717059ms","start":"2026-04-07T12:58:40.550147Z","end":"2026-04-07T12:58:40.691864Z","steps":["trace[1238774115] 'agreement among raft nodes before linearized reading' (duration: 141.493085ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:58:40.691715Z","caller":"traceutil/trace.go:171","msg":"trace[217329082] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b8a1a7a6-e588-4b4b-a6fe-98ffff4b2fd7; range_end:; response_count:1; response_revision:1781; }","duration":"196.34258ms","start":"2026-04-07T12:58:40.495354Z","end":"2026-04-07T12:58:40.691697Z","steps":["trace[217329082] 'agreement among raft nodes before linearized reading' (duration: 196.165737ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:58:40.691653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.611216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-07T12:58:40.692157Z","caller":"traceutil/trace.go:171","msg":"trace[1100507798] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1781; }","duration":"155.134886ms","start":"2026-04-07T12:58:40.536981Z","end":"2026-04-07T12:58:40.692116Z","steps":["trace[1100507798] 'agreement among raft nodes before linearized reading' (duration: 154.560415ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:58:40.886508Z","caller":"traceutil/trace.go:171","msg":"trace[1485323802] linearizableReadLoop","detail":"{readStateIndex:1850; appliedIndex:1849; }","duration":"132.665397ms","start":"2026-04-07T12:58:40.753803Z","end":"2026-04-07T12:58:40.886468Z","steps":["trace[1485323802] 'read index received' (duration: 107.172122ms)","trace[1485323802] 'applied index is now lower than readState.Index' (duration: 25.491475ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:58:40.886575Z","caller":"traceutil/trace.go:171","msg":"trace[327272101] transaction","detail":"{read_only:false; response_revision:1783; number_of_response:1; }","duration":"188.984659ms","start":"2026-04-07T12:58:40.697543Z","end":"2026-04-07T12:58:40.886528Z","steps":["trace[327272101] 'process raft request' (duration: 163.421703ms)","trace[327272101] 'compare' (duration: 25.2293ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T12:58:40.886967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.158826ms","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-07T12:58:40.887055Z","caller":"traceutil/trace.go:171","msg":"trace[1907674661] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1783; }","duration":"133.401501ms","start":"2026-04-07T12:58:40.753634Z","end":"2026-04-07T12:58:40.887035Z","steps":["trace[1907674661] 'agreement among raft nodes before linearized reading' (duration: 132.972363ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:58:40.916218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.10516ms","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-07T12:58:40.916273Z","caller":"traceutil/trace.go:171","msg":"trace[2076585213] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1784; }","duration":"159.209141ms","start":"2026-04-07T12:58:40.75705Z","end":"2026-04-07T12:58:40.91626Z","steps":["trace[2076585213] 'agreement among raft nodes before linearized reading' (duration: 159.053628ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:58:41.095726Z","caller":"traceutil/trace.go:171","msg":"trace[122734353] linearizableReadLoop","detail":"{readStateIndex:1853; appliedIndex:1852; }","duration":"132.586264ms","start":"2026-04-07T12:58:40.963098Z","end":"2026-04-07T12:58:41.095684Z","steps":["trace[122734353] 'read index received' (duration: 132.35005ms)","trace[122734353] 'applied index is now lower than readState.Index' (duration: 234.494µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:58:41.095888Z","caller":"traceutil/trace.go:171","msg":"trace[163973374] transaction","detail":"{read_only:false; response_revision:1786; number_of_response:1; }","duration":"174.752079ms","start":"2026-04-07T12:58:40.921101Z","end":"2026-04-07T12:58:41.095853Z","steps":["trace[163973374] 'process raft request' (duration: 174.265149ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:58:41.096069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.928611ms","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-07T12:58:41.096133Z","caller":"traceutil/trace.go:171","msg":"trace[273449195] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1786; }","duration":"133.054454ms","start":"2026-04-07T12:58:40.963056Z","end":"2026-04-07T12:58:41.09611Z","steps":["trace[273449195] 'agreement among raft nodes before linearized reading' (duration: 132.79735ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:58:41.122341Z","caller":"traceutil/trace.go:171","msg":"trace[2056190863] transaction","detail":"{read_only:false; response_revision:1787; number_of_response:1; }","duration":"147.107703ms","start":"2026-04-07T12:58:40.975206Z","end":"2026-04-07T12:58:41.122314Z","steps":["trace[2056190863] 'process raft request' (duration: 146.973619ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:58:41.444528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.597356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T12:58:41.444637Z","caller":"traceutil/trace.go:171","msg":"trace[1366167476] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1788; }","duration":"132.762839ms","start":"2026-04-07T12:58:41.311848Z","end":"2026-04-07T12:58:41.444611Z","steps":["trace[1366167476] 'range keys from in-memory index tree' (duration: 132.453273ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:00:19.686201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.538465ms","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-07T13:00:19.686331Z","caller":"traceutil/trace.go:171","msg":"trace[1068903321] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2549; }","duration":"103.706238ms","start":"2026-04-07T13:00:19.582598Z","end":"2026-04-07T13:00:19.686304Z","steps":["trace[1068903321] 'range keys from in-memory index tree' (duration: 103.269819ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:00:53.219922Z","caller":"traceutil/trace.go:171","msg":"trace[1874481245] transaction","detail":"{read_only:false; response_revision:2750; number_of_response:1; }","duration":"227.859826ms","start":"2026-04-07T13:00:52.992033Z","end":"2026-04-07T13:00:53.219893Z","steps":["trace[1874481245] 'process raft request' (duration: 227.685162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:04:50.47011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.090604ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T13:04:50.470211Z","caller":"traceutil/trace.go:171","msg":"trace[552181617] transaction","detail":"{read_only:false; response_revision:4943; number_of_response:1; }","duration":"216.312153ms","start":"2026-04-07T13:04:50.253882Z","end":"2026-04-07T13:04:50.470194Z","steps":["trace[552181617] 'process raft request' (duration: 113.777221ms)","trace[552181617] 'compare' (duration: 101.626886ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T13:04:50.607183Z","caller":"traceutil/trace.go:171","msg":"trace[405834283] linearizableReadLoop","detail":"{readStateIndex:5128; appliedIndex:5126; }","duration":"293.604903ms","start":"2026-04-07T13:04:50.313547Z","end":"2026-04-07T13:04:50.607152Z","steps":["trace[405834283] 'read index received' (duration: 54.272667ms)","trace[405834283] 'applied index is now lower than readState.Index' (duration: 239.330236ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T13:04:50.60735Z","caller":"traceutil/trace.go:171","msg":"trace[1646619996] transaction","detail":"{read_only:false; response_revision:4944; number_of_response:1; }","duration":"306.703168ms","start":"2026-04-07T13:04:50.300579Z","end":"2026-04-07T13:04:50.607282Z","steps":["trace[1646619996] 'process raft request' (duration: 306.394542ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:04:50.607371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.804196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T13:04:50.607568Z","caller":"traceutil/trace.go:171","msg":"trace[1391249058] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4944; }","duration":"294.084242ms","start":"2026-04-07T13:04:50.313465Z","end":"2026-04-07T13:04:50.607549Z","steps":["trace[1391249058] 'agreement among raft nodes before linearized reading' (duration: 293.812297ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:04:50.607565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T13:04:50.300554Z","time spent":"306.906281ms","remote":"127.0.0.1:38532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T13:04:50.612867Z","caller":"traceutil/trace.go:171","msg":"trace[362583605] transaction","detail":"{read_only:false; response_revision:4945; number_of_response:1; }","duration":"193.69098ms","start":"2026-04-07T13:04:50.419136Z","end":"2026-04-07T13:04:50.612827Z","steps":["trace[362583605] 'process raft request' (duration: 193.482966ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:04:50.613062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.654246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-07T13:04:50.613082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.585229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ac44e76f-e17a-44ea-8ca0-d80c89cffe61\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-04-07T13:04:50.613095Z","caller":"traceutil/trace.go:171","msg":"trace[53240057] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4946; }","duration":"227.725687ms","start":"2026-04-07T13:04:50.385361Z","end":"2026-04-07T13:04:50.613087Z","steps":["trace[53240057] 'agreement among raft nodes before linearized reading' (duration: 227.584714ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:04:50.613117Z","caller":"traceutil/trace.go:171","msg":"trace[278840726] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ac44e76f-e17a-44ea-8ca0-d80c89cffe61; range_end:; response_count:1; response_revision:4946; }","duration":"136.64774ms","start":"2026-04-07T13:04:50.476458Z","end":"2026-04-07T13:04:50.613106Z","steps":["trace[278840726] 'agreement among raft nodes before linearized reading' (duration: 136.535088ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:04:50.613118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.060024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-4ljnf.18a414dbd1f9a5e7\" ","response":"range_response_count:1 size:962"} {"level":"info","ts":"2026-04-07T13:04:50.613176Z","caller":"traceutil/trace.go:171","msg":"trace[482290736] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-4ljnf.18a414dbd1f9a5e7; range_end:; response_count:1; response_revision:4946; }","duration":"133.192396ms","start":"2026-04-07T13:04:50.479967Z","end":"2026-04-07T13:04:50.61316Z","steps":["trace[482290736] 'agreement among raft nodes before linearized reading' (duration: 133.024263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:04:50.613196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.40138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T13:04:50.613215Z","caller":"traceutil/trace.go:171","msg":"trace[2007078244] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:4946; }","duration":"165.460171ms","start":"2026-04-07T13:04:50.447748Z","end":"2026-04-07T13:04:50.613208Z","steps":["trace[2007078244] 'agreement among raft nodes before linearized reading' (duration: 165.42963ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:04:50.613234Z","caller":"traceutil/trace.go:171","msg":"trace[1822051824] transaction","detail":"{read_only:false; response_revision:4946; number_of_response:1; }","duration":"178.134648ms","start":"2026-04-07T13:04:50.435083Z","end":"2026-04-07T13:04:50.613218Z","steps":["trace[1822051824] 'process raft request' (duration: 177.69795ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:04:52.720243Z","caller":"traceutil/trace.go:171","msg":"trace[1770534615] transaction","detail":"{read_only:false; response_revision:4986; number_of_response:1; }","duration":"101.548303ms","start":"2026-04-07T13:04:52.618663Z","end":"2026-04-07T13:04:52.720211Z","steps":["trace[1770534615] 'process raft request' (duration: 101.36014ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:05:09.45613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.700315ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T13:05:09.456282Z","caller":"traceutil/trace.go:171","msg":"trace[968836309] linearizableReadLoop","detail":"{readStateIndex:5542; appliedIndex:5541; }","duration":"141.940641ms","start":"2026-04-07T13:05:09.3143Z","end":"2026-04-07T13:05:09.456241Z","steps":["trace[968836309] 'read index received' (duration: 39.908108ms)","trace[968836309] 'applied index is now lower than readState.Index' (duration: 102.031103ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T13:05:09.456756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.181671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fcf06c22-7c95-4893-8694-e9d7f686ea50\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-07T13:05:09.456752Z","caller":"traceutil/trace.go:171","msg":"trace[1856451107] transaction","detail":"{read_only:false; response_revision:5345; number_of_response:1; }","duration":"208.521728ms","start":"2026-04-07T13:05:09.248188Z","end":"2026-04-07T13:05:09.45671Z","steps":["trace[1856451107] 'process raft request' (duration: 106.115279ms)","trace[1856451107] 'compare' (duration: 101.559403ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T13:05:09.456811Z","caller":"traceutil/trace.go:171","msg":"trace[1143065371] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fcf06c22-7c95-4893-8694-e9d7f686ea50; range_end:; response_count:1; response_revision:5345; }","duration":"129.274313ms","start":"2026-04-07T13:05:09.327522Z","end":"2026-04-07T13:05:09.456797Z","steps":["trace[1143065371] 'agreement among raft nodes before linearized reading' (duration: 129.11634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:05:09.456808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.483551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T13:05:09.456931Z","caller":"traceutil/trace.go:171","msg":"trace[1250152522] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5345; }","duration":"142.687575ms","start":"2026-04-07T13:05:09.314217Z","end":"2026-04-07T13:05:09.456904Z","steps":["trace[1250152522] 'agreement among raft nodes before linearized reading' (duration: 142.467521ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:05:09.67941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.239613ms","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-04-07T13:05:09.679501Z","caller":"traceutil/trace.go:171","msg":"trace[807078280] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5345; }","duration":"121.390076ms","start":"2026-04-07T13:05:09.558093Z","end":"2026-04-07T13:05:09.679483Z","steps":["trace[807078280] 'range keys from in-memory index tree' (duration: 121.073449ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:05:09.859973Z","caller":"traceutil/trace.go:171","msg":"trace[122531281] linearizableReadLoop","detail":"{readStateIndex:5544; appliedIndex:5543; }","duration":"109.001303ms","start":"2026-04-07T13:05:09.750944Z","end":"2026-04-07T13:05:09.859945Z","steps":["trace[122531281] 'read index received' (duration: 108.803339ms)","trace[122531281] 'applied index is now lower than readState.Index' (duration: 197.034µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T13:05:09.860184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.211216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T13:05:09.860189Z","caller":"traceutil/trace.go:171","msg":"trace[404915095] transaction","detail":"{read_only:false; response_revision:5347; number_of_response:1; }","duration":"174.716015ms","start":"2026-04-07T13:05:09.685451Z","end":"2026-04-07T13:05:09.860167Z","steps":["trace[404915095] 'process raft request' (duration: 174.354828ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:05:09.860243Z","caller":"traceutil/trace.go:171","msg":"trace[537506568] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:5347; }","duration":"109.326579ms","start":"2026-04-07T13:05:09.7509Z","end":"2026-04-07T13:05:09.860227Z","steps":["trace[537506568] 'agreement among raft nodes before linearized reading' (duration: 109.147546ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:06:35.822528Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2987} {"level":"info","ts":"2026-04-07T13:06:35.892559Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2987,"took":"68.54007ms","hash":2342988194,"current-db-size-bytes":58564608,"current-db-size":"59 MB","current-db-size-in-use-bytes":34107392,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-07T13:06:35.892616Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2342988194,"revision":2987,"compact-revision":-1} {"level":"warn","ts":"2026-04-07T13:11:09.237731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.240023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T13:11:09.237883Z","caller":"traceutil/trace.go:171","msg":"trace[285377139] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8148; }","duration":"233.408696ms","start":"2026-04-07T13:11:09.004452Z","end":"2026-04-07T13:11:09.23786Z","steps":["trace[285377139] 'range keys from in-memory index tree' (duration: 233.122631ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:11:09.237964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.627108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-gm844\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-07T13:11:09.238027Z","caller":"traceutil/trace.go:171","msg":"trace[109011609] range","detail":"{range_begin:/registry/pods/openstack/keepalived-gm844; range_end:; response_count:1; response_revision:8148; }","duration":"242.73677ms","start":"2026-04-07T13:11:08.995274Z","end":"2026-04-07T13:11:09.238011Z","steps":["trace[109011609] 'range keys from in-memory index tree' (duration: 242.500056ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:11:09.405324Z","caller":"traceutil/trace.go:171","msg":"trace[2094011501] transaction","detail":"{read_only:false; response_revision:8149; number_of_response:1; }","duration":"116.249375ms","start":"2026-04-07T13:11:09.289051Z","end":"2026-04-07T13:11:09.405301Z","steps":["trace[2094011501] 'process raft request' (duration: 115.921188ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:11:21.056034Z","caller":"traceutil/trace.go:171","msg":"trace[1925568762] linearizableReadLoop","detail":"{readStateIndex:8495; appliedIndex:8494; }","duration":"207.487291ms","start":"2026-04-07T13:11:20.848519Z","end":"2026-04-07T13:11:21.056006Z","steps":["trace[1925568762] 'read index received' (duration: 207.283327ms)","trace[1925568762] 'applied index is now lower than readState.Index' (duration: 202.714µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T13:11:21.056139Z","caller":"traceutil/trace.go:171","msg":"trace[530142182] transaction","detail":"{read_only:false; response_revision:8210; number_of_response:1; }","duration":"208.850496ms","start":"2026-04-07T13:11:20.847258Z","end":"2026-04-07T13:11:21.056108Z","steps":["trace[530142182] 'process raft request' (duration: 208.573371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:11:21.056279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.736956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-07T13:11:21.056323Z","caller":"traceutil/trace.go:171","msg":"trace[56241220] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8210; }","duration":"207.886509ms","start":"2026-04-07T13:11:20.848427Z","end":"2026-04-07T13:11:21.056313Z","steps":["trace[56241220] 'agreement among raft nodes before linearized reading' (duration: 207.722386ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:11:21.149609Z","caller":"traceutil/trace.go:171","msg":"trace[755630137] transaction","detail":"{read_only:false; response_revision:8211; number_of_response:1; }","duration":"118.754082ms","start":"2026-04-07T13:11:21.030795Z","end":"2026-04-07T13:11:21.149549Z","steps":["trace[755630137] 'process raft request' (duration: 99.913648ms)","trace[755630137] 'compare' (duration: 18.639541ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T13:11:21.149805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.934973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-07T13:11:21.149874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.793208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1633"} {"level":"info","ts":"2026-04-07T13:11:21.149917Z","caller":"traceutil/trace.go:171","msg":"trace[595382950] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8211; }","duration":"263.089446ms","start":"2026-04-07T13:11:20.886802Z","end":"2026-04-07T13:11:21.149891Z","steps":["trace[595382950] 'agreement among raft nodes before linearized reading' (duration: 262.678878ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:11:21.149945Z","caller":"traceutil/trace.go:171","msg":"trace[2121303242] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:8211; }","duration":"131.938191ms","start":"2026-04-07T13:11:21.017984Z","end":"2026-04-07T13:11:21.149922Z","steps":["trace[2121303242] 'agreement among raft nodes before linearized reading' (duration: 131.550003ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:11:21.818144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.070425ms","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-04-07T13:11:21.818271Z","caller":"traceutil/trace.go:171","msg":"trace[1031717993] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8215; }","duration":"247.228108ms","start":"2026-04-07T13:11:21.571014Z","end":"2026-04-07T13:11:21.818242Z","steps":["trace[1031717993] 'range keys from in-memory index tree' (duration: 246.879991ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:11:22.355503Z","caller":"traceutil/trace.go:171","msg":"trace[1552212744] transaction","detail":"{read_only:false; response_revision:8218; number_of_response:1; }","duration":"129.373283ms","start":"2026-04-07T13:11:22.226104Z","end":"2026-04-07T13:11:22.355477Z","steps":["trace[1552212744] 'process raft request' (duration: 129.22091ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:11:22.424843Z","caller":"traceutil/trace.go:171","msg":"trace[1747309804] transaction","detail":"{read_only:false; response_revision:8219; number_of_response:1; }","duration":"196.061156ms","start":"2026-04-07T13:11:22.228744Z","end":"2026-04-07T13:11:22.424805Z","steps":["trace[1747309804] 'process raft request' (duration: 186.586868ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:11:35.828861Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6124} {"level":"info","ts":"2026-04-07T13:11:35.932963Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6124,"took":"101.08771ms","hash":1752855947,"current-db-size-bytes":58564608,"current-db-size":"59 MB","current-db-size-in-use-bytes":23109632,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-07T13:11:35.933047Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1752855947,"revision":6124,"compact-revision":2987} {"level":"info","ts":"2026-04-07T13:12:03.283996Z","caller":"traceutil/trace.go:171","msg":"trace[1734462210] linearizableReadLoop","detail":"{readStateIndex:8829; appliedIndex:8828; }","duration":"136.10682ms","start":"2026-04-07T13:12:03.14786Z","end":"2026-04-07T13:12:03.283966Z","steps":["trace[1734462210] 'read index received' (duration: 130.82713ms)","trace[1734462210] 'applied index is now lower than readState.Index' (duration: 5.27844ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T13:12:03.284202Z","caller":"traceutil/trace.go:171","msg":"trace[1950104532] transaction","detail":"{read_only:false; response_revision:8530; number_of_response:1; }","duration":"137.086148ms","start":"2026-04-07T13:12:03.147092Z","end":"2026-04-07T13:12:03.284178Z","steps":["trace[1950104532] 'process raft request' (duration: 131.668236ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:12:03.284964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.054707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-flkv6\" ","response":"range_response_count:1 size:2802"} {"level":"info","ts":"2026-04-07T13:12:03.285068Z","caller":"traceutil/trace.go:171","msg":"trace[1868567389] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-flkv6; range_end:; response_count:1; response_revision:8530; }","duration":"137.198629ms","start":"2026-04-07T13:12:03.147846Z","end":"2026-04-07T13:12:03.285044Z","steps":["trace[1868567389] 'agreement among raft nodes before linearized reading' (duration: 136.238162ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:12:03.447583Z","caller":"traceutil/trace.go:171","msg":"trace[868127994] linearizableReadLoop","detail":"{readStateIndex:8830; appliedIndex:8829; }","duration":"155.934961ms","start":"2026-04-07T13:12:03.291617Z","end":"2026-04-07T13:12:03.447552Z","steps":["trace[868127994] 'read index received' (duration: 145.794821ms)","trace[868127994] 'applied index is now lower than readState.Index' (duration: 10.13886ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T13:12:03.447715Z","caller":"traceutil/trace.go:171","msg":"trace[1537410775] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8531; }","duration":"159.447708ms","start":"2026-04-07T13:12:03.288257Z","end":"2026-04-07T13:12:03.447705Z","steps":["trace[1537410775] 'process raft request' (duration: 149.138623ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:12:03.448014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.38671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-flkv6\" ","response":"range_response_count:1 size:4648"} {"level":"info","ts":"2026-04-07T13:12:03.448115Z","caller":"traceutil/trace.go:171","msg":"trace[2121849189] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-flkv6; range_end:; response_count:1; response_revision:8531; }","duration":"156.523793ms","start":"2026-04-07T13:12:03.291569Z","end":"2026-04-07T13:12:03.448093Z","steps":["trace[2121849189] 'agreement among raft nodes before linearized reading' (duration: 156.31862ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:12:03.45633Z","caller":"traceutil/trace.go:171","msg":"trace[37121830] transaction","detail":"{read_only:false; response_revision:8532; number_of_response:1; }","duration":"141.508501ms","start":"2026-04-07T13:12:03.3148Z","end":"2026-04-07T13:12:03.456308Z","steps":["trace[37121830] 'process raft request' (duration: 141.142423ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:12:03.456325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.121339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T13:12:03.456422Z","caller":"traceutil/trace.go:171","msg":"trace[1989225261] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8532; }","duration":"144.284022ms","start":"2026-04-07T13:12:03.312114Z","end":"2026-04-07T13:12:03.456398Z","steps":["trace[1989225261] 'agreement among raft nodes before linearized reading' (duration: 144.046438ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:12:03.456495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.50436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-flkv6\" ","response":"range_response_count:1 size:4648"} {"level":"info","ts":"2026-04-07T13:12:03.456595Z","caller":"traceutil/trace.go:171","msg":"trace[673591089] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-flkv6; range_end:; response_count:1; response_revision:8532; }","duration":"141.663463ms","start":"2026-04-07T13:12:03.314911Z","end":"2026-04-07T13:12:03.456574Z","steps":["trace[673591089] 'agreement among raft nodes before linearized reading' (duration: 141.353768ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:12:03.456351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.904598ms","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-07T13:12:03.456832Z","caller":"traceutil/trace.go:171","msg":"trace[1386717256] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8532; }","duration":"159.405007ms","start":"2026-04-07T13:12:03.297407Z","end":"2026-04-07T13:12:03.456812Z","steps":["trace[1386717256] 'agreement among raft nodes before linearized reading' (duration: 158.837376ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:12:04.004935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.176543ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T13:12:04.00517Z","caller":"traceutil/trace.go:171","msg":"trace[139031804] linearizableReadLoop","detail":"{readStateIndex:8837; appliedIndex:8836; }","duration":"127.336074ms","start":"2026-04-07T13:12:03.877814Z","end":"2026-04-07T13:12:04.00515Z","steps":["trace[139031804] 'read index received' (duration: 7.984899ms)","trace[139031804] 'applied index is now lower than readState.Index' (duration: 119.349125ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T13:12:04.00524Z","caller":"traceutil/trace.go:171","msg":"trace[1168234308] transaction","detail":"{read_only:false; response_revision:8538; number_of_response:1; }","duration":"234.657012ms","start":"2026-04-07T13:12:03.770544Z","end":"2026-04-07T13:12:04.005201Z","steps":["trace[1168234308] 'process raft request' (duration: 115.322528ms)","trace[1168234308] 'compare' (duration: 117.791305ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T13:12:04.00544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.596058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-04-07T13:12:04.005572Z","caller":"traceutil/trace.go:171","msg":"trace[806510273] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8538; }","duration":"127.785472ms","start":"2026-04-07T13:12:03.877756Z","end":"2026-04-07T13:12:04.005541Z","steps":["trace[806510273] 'agreement among raft nodes before linearized reading' (duration: 127.464266ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:12:04.206632Z","caller":"traceutil/trace.go:171","msg":"trace[659550639] linearizableReadLoop","detail":"{readStateIndex:8838; appliedIndex:8837; }","duration":"162.631958ms","start":"2026-04-07T13:12:04.043967Z","end":"2026-04-07T13:12:04.206599Z","steps":["trace[659550639] 'read index received' (duration: 92.318156ms)","trace[659550639] 'applied index is now lower than readState.Index' (duration: 70.311792ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T13:12:04.206855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.859802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T13:12:04.206823Z","caller":"traceutil/trace.go:171","msg":"trace[1188610005] transaction","detail":"{read_only:false; response_revision:8539; number_of_response:1; }","duration":"193.009169ms","start":"2026-04-07T13:12:04.013774Z","end":"2026-04-07T13:12:04.206783Z","steps":["trace[1188610005] 'process raft request' (duration: 122.658735ms)","trace[1188610005] 'compare' (duration: 70.034777ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T13:12:04.206926Z","caller":"traceutil/trace.go:171","msg":"trace[1751253423] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8539; }","duration":"163.006325ms","start":"2026-04-07T13:12:04.043906Z","end":"2026-04-07T13:12:04.206913Z","steps":["trace[1751253423] 'agreement among raft nodes before linearized reading' (duration: 162.859712ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:12:04.241736Z","caller":"traceutil/trace.go:171","msg":"trace[930667416] transaction","detail":"{read_only:false; response_revision:8540; number_of_response:1; }","duration":"110.422566ms","start":"2026-04-07T13:12:04.131279Z","end":"2026-04-07T13:12:04.241702Z","steps":["trace[930667416] 'process raft request' (duration: 110.213421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:12:04.263744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.361095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T13:12:04.263841Z","caller":"traceutil/trace.go:171","msg":"trace[627902169] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:8541; }","duration":"184.522308ms","start":"2026-04-07T13:12:04.079299Z","end":"2026-04-07T13:12:04.263821Z","steps":["trace[627902169] 'agreement among raft nodes before linearized reading' (duration: 184.369585ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:12:04.264252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.321823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T13:12:04.264309Z","caller":"traceutil/trace.go:171","msg":"trace[1585941362] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8541; }","duration":"170.428165ms","start":"2026-04-07T13:12:04.093867Z","end":"2026-04-07T13:12:04.264295Z","steps":["trace[1585941362] 'agreement among raft nodes before linearized reading' (duration: 170.201371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:12:04.264549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.96805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5732"} {"level":"info","ts":"2026-04-07T13:12:04.264769Z","caller":"traceutil/trace.go:171","msg":"trace[1527898261] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8541; }","duration":"125.576121ms","start":"2026-04-07T13:12:04.139138Z","end":"2026-04-07T13:12:04.264714Z","steps":["trace[1527898261] 'agreement among raft nodes before linearized reading' (duration: 124.820018ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:12:52.498514Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000247a.wal"} {"level":"info","ts":"2026-04-07T13:13:05.059301Z","caller":"traceutil/trace.go:171","msg":"trace[794277888] transaction","detail":"{read_only:false; response_revision:9200; number_of_response:1; }","duration":"103.132009ms","start":"2026-04-07T13:13:04.956138Z","end":"2026-04-07T13:13:05.05927Z","steps":["trace[794277888] 'process raft request' (duration: 102.973796ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:14:11.640578Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e3aaa5c123e150e0","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-07T13:14:11.645881Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-07T13:14:11.645951Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-07T13:16:35.835534Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8293} {"level":"info","ts":"2026-04-07T13:16:35.918565Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8293,"took":"80.474741ms","hash":3981817770,"current-db-size-bytes":58564608,"current-db-size":"59 MB","current-db-size-in-use-bytes":24862720,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-07T13:16:35.918662Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3981817770,"revision":8293,"compact-revision":6124} {"level":"info","ts":"2026-04-07T13:21:35.844889Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10687} {"level":"info","ts":"2026-04-07T13:21:35.922561Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10687,"took":"74.798835ms","hash":1269775809,"current-db-size-bytes":58564608,"current-db-size":"59 MB","current-db-size-in-use-bytes":20283392,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-07T13:21:35.922659Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1269775809,"revision":10687,"compact-revision":8293}