{"level":"warn","ts":"2026-07-01T10:55:15.39984Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-01T10:55:15.399939Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.57: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.57:2380","--initial-cluster=instance=https://199.204.45.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.57:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-01T10:55:15.400024Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-01T10:55:15.400044Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-07-01T10:55:15.400064Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-01T10:55:15.400915Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"]} {"level":"info","ts":"2026-07-01T10:55:15.401028Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.57:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-01T10:55:15.406794Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.53131ms"} {"level":"info","ts":"2026-07-01T10:55:15.415256Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b6478f0ac5aeb8e1","cluster-id":"6c58cff80d4a5b62"} {"level":"info","ts":"2026-07-01T10:55:15.415349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=()"} {"level":"info","ts":"2026-07-01T10:55:15.415373Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 0"} {"level":"info","ts":"2026-07-01T10:55:15.415382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b6478f0ac5aeb8e1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-01T10:55:15.415403Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 1"} {"level":"info","ts":"2026-07-01T10:55:15.415441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"warn","ts":"2026-07-01T10:55:15.423403Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-01T10:55:15.424898Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-01T10:55:15.425948Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-01T10:55:15.42812Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b6478f0ac5aeb8e1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-01T10:55:15.428269Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b6478f0ac5aeb8e1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-01T10:55:15.428618Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-01T10:55:15.428721Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-01T10:55:15.428737Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-01T10:55:15.43538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"info","ts":"2026-07-01T10:55:15.43563Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","added-peer-id":"b6478f0ac5aeb8e1","added-peer-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-07-01T10:55:15.437947Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-01T10:55:15.43827Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b6478f0ac5aeb8e1","initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-01T10:55:15.438308Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-01T10:55:15.438416Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-07-01T10:55:15.438436Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-07-01T10:55:16.116206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 is starting a new election at term 1"} {"level":"info","ts":"2026-07-01T10:55:16.116292Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-01T10:55:16.116325Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgPreVoteResp from b6478f0ac5aeb8e1 at term 1"} {"level":"info","ts":"2026-07-01T10:55:16.116349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became candidate at term 2"} {"level":"info","ts":"2026-07-01T10:55:16.116362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgVoteResp from b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-07-01T10:55:16.116385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became leader at term 2"} {"level":"info","ts":"2026-07-01T10:55:16.1164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b6478f0ac5aeb8e1 elected leader b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-07-01T10:55:16.117549Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b6478f0ac5aeb8e1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.57:2379]}","request-path":"/0/members/b6478f0ac5aeb8e1/attributes","cluster-id":"6c58cff80d4a5b62","publish-timeout":"7s"} {"level":"info","ts":"2026-07-01T10:55:16.11755Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-01T10:55:16.117586Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-01T10:55:16.117874Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-01T10:55:16.117935Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-01T10:55:16.120049Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.57:2379"} {"level":"info","ts":"2026-07-01T10:55:16.120294Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T10:55:16.122929Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T10:55:16.123052Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T10:55:16.123096Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T10:55:16.124215Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-01T10:55:19.939375Z","caller":"traceutil/trace.go:171","msg":"trace[1613592140] transaction","detail":"{read_only:false; response_revision:249; number_of_response:1; }","duration":"163.704371ms","start":"2026-07-01T10:55:19.775607Z","end":"2026-07-01T10:55:19.939311Z","steps":["trace[1613592140] 'process raft request' (duration: 163.50802ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:55:20.174776Z","caller":"traceutil/trace.go:171","msg":"trace[1483448391] linearizableReadLoop","detail":"{readStateIndex:256; appliedIndex:255; }","duration":"231.815058ms","start":"2026-07-01T10:55:19.942936Z","end":"2026-07-01T10:55:20.174751Z","steps":["trace[1483448391] 'read index received' (duration: 231.707527ms)","trace[1483448391] 'applied index is now lower than readState.Index' (duration: 106.731µs)"],"step_count":2} {"level":"warn","ts":"2026-07-01T10:55:20.175119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.169191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-co0mc7\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T10:55:20.175134Z","caller":"traceutil/trace.go:171","msg":"trace[783473604] transaction","detail":"{read_only:false; response_revision:250; number_of_response:1; }","duration":"297.973593ms","start":"2026-07-01T10:55:19.877128Z","end":"2026-07-01T10:55:20.175101Z","steps":["trace[783473604] 'process raft request' (duration: 297.48318ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:55:20.175199Z","caller":"traceutil/trace.go:171","msg":"trace[1133649631] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-co0mc7; range_end:; response_count:0; response_revision:250; }","duration":"232.305921ms","start":"2026-07-01T10:55:19.942881Z","end":"2026-07-01T10:55:20.175187Z","steps":["trace[1133649631] 'agreement among raft nodes before linearized reading' (duration: 232.10104ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:55:20.175136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.65865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T10:55:20.175403Z","caller":"traceutil/trace.go:171","msg":"trace[1094609141] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:250; }","duration":"191.961422ms","start":"2026-07-01T10:55:19.983418Z","end":"2026-07-01T10:55:20.175379Z","steps":["trace[1094609141] 'agreement among raft nodes before linearized reading' (duration: 191.660179ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:55:31.400136Z","caller":"traceutil/trace.go:171","msg":"trace[1587592854] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"114.952627ms","start":"2026-07-01T10:55:31.285143Z","end":"2026-07-01T10:55:31.400095Z","steps":["trace[1587592854] 'process raft request' (duration: 111.141539ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:55:54.476846Z","caller":"traceutil/trace.go:171","msg":"trace[1814281525] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:652; }","duration":"198.581115ms","start":"2026-07-01T10:55:54.278239Z","end":"2026-07-01T10:55:54.47682Z","steps":["trace[1814281525] 'read index received' (duration: 194.705254ms)","trace[1814281525] 'applied index is now lower than readState.Index' (duration: 3.875041ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:55:54.477012Z","caller":"traceutil/trace.go:171","msg":"trace[603588543] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"200.255688ms","start":"2026-07-01T10:55:54.276723Z","end":"2026-07-01T10:55:54.476979Z","steps":["trace[603588543] 'process raft request' (duration: 196.205079ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:55:54.477176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.905979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:74769"} {"level":"info","ts":"2026-07-01T10:55:54.477637Z","caller":"traceutil/trace.go:171","msg":"trace[1869192640] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:630; }","duration":"199.345709ms","start":"2026-07-01T10:55:54.278217Z","end":"2026-07-01T10:55:54.477562Z","steps":["trace[1869192640] 'agreement among raft nodes before linearized reading' (duration: 198.760603ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:55:54.481559Z","caller":"traceutil/trace.go:171","msg":"trace[570543894] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"144.005717ms","start":"2026-07-01T10:55:54.337528Z","end":"2026-07-01T10:55:54.481534Z","steps":["trace[570543894] 'process raft request' (duration: 143.888332ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:55:54.504436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.927054ms","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-07-01T10:55:54.504511Z","caller":"traceutil/trace.go:171","msg":"trace[1847291090] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:631; }","duration":"144.039639ms","start":"2026-07-01T10:55:54.360453Z","end":"2026-07-01T10:55:54.504493Z","steps":["trace[1847291090] 'agreement among raft nodes before linearized reading' (duration: 143.914753ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:55:54.504764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.220732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-7bm5c\" ","response":"range_response_count:1 size:4679"} {"level":"info","ts":"2026-07-01T10:55:54.504823Z","caller":"traceutil/trace.go:171","msg":"trace[23313221] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-7bm5c; range_end:; response_count:1; response_revision:631; }","duration":"220.307707ms","start":"2026-07-01T10:55:54.284503Z","end":"2026-07-01T10:55:54.504811Z","steps":["trace[23313221] 'agreement among raft nodes before linearized reading' (duration: 220.15468ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:56:00.707743Z","caller":"traceutil/trace.go:171","msg":"trace[62390389] linearizableReadLoop","detail":"{readStateIndex:725; appliedIndex:724; }","duration":"149.825319ms","start":"2026-07-01T10:56:00.557875Z","end":"2026-07-01T10:56:00.707701Z","steps":["trace[62390389] 'read index received' (duration: 149.430022ms)","trace[62390389] 'applied index is now lower than readState.Index' (duration: 393.776µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:56:00.707801Z","caller":"traceutil/trace.go:171","msg":"trace[80279148] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"387.670712ms","start":"2026-07-01T10:56:00.320089Z","end":"2026-07-01T10:56:00.707759Z","steps":["trace[80279148] 'process raft request' (duration: 387.351089ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:56:00.70821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.30041ms","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-07-01T10:56:00.708308Z","caller":"traceutil/trace.go:171","msg":"trace[130768787] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:700; }","duration":"150.462756ms","start":"2026-07-01T10:56:00.557822Z","end":"2026-07-01T10:56:00.708284Z","steps":["trace[130768787] 'agreement among raft nodes before linearized reading' (duration: 150.040298ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:56:00.70847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:56:00.320052Z","time spent":"387.842708ms","remote":"127.0.0.1:40196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T10:56:00.909618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.017799ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T10:56:00.909715Z","caller":"traceutil/trace.go:171","msg":"trace[265849895] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"194.38679ms","start":"2026-07-01T10:56:00.71531Z","end":"2026-07-01T10:56:00.909697Z","steps":["trace[265849895] 'process raft request' (duration: 52.059787ms)","trace[265849895] 'compare' (duration: 141.877843ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:56:16.417544Z","caller":"traceutil/trace.go:171","msg":"trace[793796980] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"124.011786ms","start":"2026-07-01T10:56:16.293507Z","end":"2026-07-01T10:56:16.417519Z","steps":["trace[793796980] 'process raft request' (duration: 123.804729ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:56:16.601074Z","caller":"traceutil/trace.go:171","msg":"trace[217544744] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"175.589237ms","start":"2026-07-01T10:56:16.425457Z","end":"2026-07-01T10:56:16.601046Z","steps":["trace[217544744] 'process raft request' (duration: 175.406651ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:56:46.154821Z","caller":"traceutil/trace.go:171","msg":"trace[97552394] linearizableReadLoop","detail":"{readStateIndex:1248; appliedIndex:1247; }","duration":"172.186786ms","start":"2026-07-01T10:56:45.982609Z","end":"2026-07-01T10:56:46.154795Z","steps":["trace[97552394] 'read index received' (duration: 172.017022ms)","trace[97552394] 'applied index is now lower than readState.Index' (duration: 168.154µs)"],"step_count":2} {"level":"warn","ts":"2026-07-01T10:56:46.155129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.487544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-01T10:56:46.155174Z","caller":"traceutil/trace.go:171","msg":"trace[1912660817] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1209; }","duration":"172.591627ms","start":"2026-07-01T10:56:45.982571Z","end":"2026-07-01T10:56:46.155163Z","steps":["trace[1912660817] 'agreement among raft nodes before linearized reading' (duration: 172.32359ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:56:46.155348Z","caller":"traceutil/trace.go:171","msg":"trace[910985258] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"235.567025ms","start":"2026-07-01T10:56:45.919606Z","end":"2026-07-01T10:56:46.155173Z","steps":["trace[910985258] 'process raft request' (duration: 235.029592ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:57:32.736661Z","caller":"traceutil/trace.go:171","msg":"trace[1746908168] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"191.584065ms","start":"2026-07-01T10:57:32.545049Z","end":"2026-07-01T10:57:32.736633Z","steps":["trace[1746908168] 'process raft request' (duration: 191.421642ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:57:32.769018Z","caller":"traceutil/trace.go:171","msg":"trace[1133465291] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"223.26406ms","start":"2026-07-01T10:57:32.545725Z","end":"2026-07-01T10:57:32.768989Z","steps":["trace[1133465291] 'process raft request' (duration: 199.002773ms)","trace[1133465291] 'compare' (duration: 24.161606ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T10:57:44.273279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.918497ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-01T10:57:44.273395Z","caller":"traceutil/trace.go:171","msg":"trace[1931405619] linearizableReadLoop","detail":"{readStateIndex:2051; appliedIndex:2050; }","duration":"109.508446ms","start":"2026-07-01T10:57:44.163869Z","end":"2026-07-01T10:57:44.273378Z","steps":["trace[1931405619] 'read index received' (duration: 34.63µs)","trace[1931405619] 'applied index is now lower than readState.Index' (duration: 109.472286ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T10:57:44.273472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.588077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T10:57:44.273558Z","caller":"traceutil/trace.go:171","msg":"trace[1859820790] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1973; }","duration":"109.70478ms","start":"2026-07-01T10:57:44.163841Z","end":"2026-07-01T10:57:44.273545Z","steps":["trace[1859820790] 'agreement among raft nodes before linearized reading' (duration: 109.580388ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:58:07.30749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.212444ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T10:58:07.307671Z","caller":"traceutil/trace.go:171","msg":"trace[655274026] linearizableReadLoop","detail":"{readStateIndex:2194; appliedIndex:2193; }","duration":"142.768608ms","start":"2026-07-01T10:58:07.164877Z","end":"2026-07-01T10:58:07.307645Z","steps":["trace[655274026] 'read index received' (duration: 61.56µs)","trace[655274026] 'applied index is now lower than readState.Index' (duration: 142.705418ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:58:07.307701Z","caller":"traceutil/trace.go:171","msg":"trace[1744486709] transaction","detail":"{read_only:false; response_revision:2112; number_of_response:1; }","duration":"371.687159ms","start":"2026-07-01T10:58:06.935972Z","end":"2026-07-01T10:58:07.307659Z","steps":["trace[1744486709] 'process raft request' (duration: 133.153041ms)","trace[1744486709] 'compare' (duration: 237.9785ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T10:58:07.307818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.932831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-01T10:58:07.308073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:58:06.93596Z","time spent":"371.82349ms","remote":"127.0.0.1:40292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T10:58:07.308088Z","caller":"traceutil/trace.go:171","msg":"trace[279548965] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2112; }","duration":"143.262294ms","start":"2026-07-01T10:58:07.164809Z","end":"2026-07-01T10:58:07.308071Z","steps":["trace[279548965] 'agreement among raft nodes before linearized reading' (duration: 142.94675ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:58:07.426332Z","caller":"traceutil/trace.go:171","msg":"trace[491198661] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"114.733402ms","start":"2026-07-01T10:58:07.311572Z","end":"2026-07-01T10:58:07.426305Z","steps":["trace[491198661] 'process raft request' (duration: 112.857308ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:58:07.664137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.641784ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T10:58:07.664369Z","caller":"traceutil/trace.go:171","msg":"trace[1255743592] linearizableReadLoop","detail":"{readStateIndex:2197; appliedIndex:2195; }","duration":"185.592303ms","start":"2026-07-01T10:58:07.478757Z","end":"2026-07-01T10:58:07.664349Z","steps":["trace[1255743592] 'read index received' (duration: 54.727246ms)","trace[1255743592] 'applied index is now lower than readState.Index' (duration: 130.863797ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:58:07.664371Z","caller":"traceutil/trace.go:171","msg":"trace[1094614355] transaction","detail":"{read_only:false; response_revision:2114; number_of_response:1; }","duration":"214.011856ms","start":"2026-07-01T10:58:07.450332Z","end":"2026-07-01T10:58:07.664344Z","steps":["trace[1094614355] 'process raft request' (duration: 83.047348ms)","trace[1094614355] 'compare' (duration: 130.505043ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T10:58:07.664754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.969908ms","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-07-01T10:58:07.664845Z","caller":"traceutil/trace.go:171","msg":"trace[1410245138] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2115; }","duration":"186.10782ms","start":"2026-07-01T10:58:07.478707Z","end":"2026-07-01T10:58:07.664815Z","steps":["trace[1410245138] 'agreement among raft nodes before linearized reading' (duration: 185.808986ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:58:07.664869Z","caller":"traceutil/trace.go:171","msg":"trace[861710540] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"212.250014ms","start":"2026-07-01T10:58:07.452601Z","end":"2026-07-01T10:58:07.664851Z","steps":["trace[861710540] 'process raft request' (duration: 211.667066ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:59:44.049367Z","caller":"traceutil/trace.go:171","msg":"trace[1232426821] linearizableReadLoop","detail":"{readStateIndex:2847; appliedIndex:2846; }","duration":"115.859366ms","start":"2026-07-01T10:59:43.93348Z","end":"2026-07-01T10:59:44.04934Z","steps":["trace[1232426821] 'read index received' (duration: 115.665704ms)","trace[1232426821] 'applied index is now lower than readState.Index' (duration: 191.502µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:59:44.049493Z","caller":"traceutil/trace.go:171","msg":"trace[2064678610] transaction","detail":"{read_only:false; response_revision:2743; number_of_response:1; }","duration":"132.346469ms","start":"2026-07-01T10:59:43.917108Z","end":"2026-07-01T10:59:44.049454Z","steps":["trace[2064678610] 'process raft request' (duration: 132.030166ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:59:44.049576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.070678ms","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-07-01T10:59:44.049652Z","caller":"traceutil/trace.go:171","msg":"trace[896148751] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2743; }","duration":"116.244018ms","start":"2026-07-01T10:59:43.933382Z","end":"2026-07-01T10:59:44.049626Z","steps":["trace[896148751] 'agreement among raft nodes before linearized reading' (duration: 116.115227ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:59:44.197274Z","caller":"traceutil/trace.go:171","msg":"trace[329143861] linearizableReadLoop","detail":"{readStateIndex:2849; appliedIndex:2847; }","duration":"147.788879ms","start":"2026-07-01T10:59:44.049468Z","end":"2026-07-01T10:59:44.197257Z","steps":["trace[329143861] 'read index received' (duration: 71.587553ms)","trace[329143861] 'applied index is now lower than readState.Index' (duration: 76.200316ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T10:59:44.197616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.111726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-01T10:59:44.197647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.730006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T10:59:44.197715Z","caller":"traceutil/trace.go:171","msg":"trace[886009661] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:2745; }","duration":"234.845227ms","start":"2026-07-01T10:59:43.962855Z","end":"2026-07-01T10:59:44.197701Z","steps":["trace[886009661] 'agreement among raft nodes before linearized reading' (duration: 234.684396ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:59:44.197676Z","caller":"traceutil/trace.go:171","msg":"trace[522398511] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2745; }","duration":"144.237738ms","start":"2026-07-01T10:59:44.05343Z","end":"2026-07-01T10:59:44.197668Z","steps":["trace[522398511] 'agreement among raft nodes before linearized reading' (duration: 144.140847ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:59:44.19786Z","caller":"traceutil/trace.go:171","msg":"trace[170288417] transaction","detail":"{read_only:false; response_revision:2745; number_of_response:1; }","duration":"189.279324ms","start":"2026-07-01T10:59:44.008554Z","end":"2026-07-01T10:59:44.197834Z","steps":["trace[170288417] 'process raft request' (duration: 188.666808ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:59:44.197609Z","caller":"traceutil/trace.go:171","msg":"trace[74022171] transaction","detail":"{read_only:false; response_revision:2744; number_of_response:1; }","duration":"190.201333ms","start":"2026-07-01T10:59:44.007378Z","end":"2026-07-01T10:59:44.197579Z","steps":["trace[74022171] 'process raft request' (duration: 113.622343ms)","trace[74022171] 'compare' (duration: 75.905543ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T11:03:30.379457Z","caller":"traceutil/trace.go:171","msg":"trace[2130285623] linearizableReadLoop","detail":"{readStateIndex:4610; appliedIndex:4609; }","duration":"109.242308ms","start":"2026-07-01T11:03:30.270185Z","end":"2026-07-01T11:03:30.379428Z","steps":["trace[2130285623] 'read index received' (duration: 109.204227ms)","trace[2130285623] 'applied index is now lower than readState.Index' (duration: 36.981µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T11:03:30.379537Z","caller":"traceutil/trace.go:171","msg":"trace[1847314486] transaction","detail":"{read_only:false; response_revision:4436; number_of_response:1; }","duration":"136.120896ms","start":"2026-07-01T11:03:30.243395Z","end":"2026-07-01T11:03:30.379516Z","steps":["trace[1847314486] 'process raft request' (duration: 135.878412ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T11:03:30.379692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.481832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T11:03:30.379852Z","caller":"traceutil/trace.go:171","msg":"trace[1509481527] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:4436; }","duration":"109.618263ms","start":"2026-07-01T11:03:30.270146Z","end":"2026-07-01T11:03:30.379764Z","steps":["trace[1509481527] 'agreement among raft nodes before linearized reading' (duration: 109.449541ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T11:03:30.438212Z","caller":"traceutil/trace.go:171","msg":"trace[1808165533] transaction","detail":"{read_only:false; response_revision:4437; number_of_response:1; }","duration":"162.410296ms","start":"2026-07-01T11:03:30.275759Z","end":"2026-07-01T11:03:30.43817Z","steps":["trace[1808165533] 'process raft request' (duration: 160.100727ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T11:03:30.443068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.628212ms","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-07-01T11:03:30.443185Z","caller":"traceutil/trace.go:171","msg":"trace[877991995] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:4438; }","duration":"127.843465ms","start":"2026-07-01T11:03:30.315316Z","end":"2026-07-01T11:03:30.443159Z","steps":["trace[877991995] 'agreement among raft nodes before linearized reading' (duration: 127.52208ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T11:03:30.444002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.575795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/grafana-tls\" ","response":"range_response_count:1 size:4293"} {"level":"info","ts":"2026-07-01T11:03:30.444069Z","caller":"traceutil/trace.go:171","msg":"trace[162155705] range","detail":"{range_begin:/registry/secrets/monitoring/grafana-tls; range_end:; response_count:1; response_revision:4438; }","duration":"115.667627ms","start":"2026-07-01T11:03:30.328374Z","end":"2026-07-01T11:03:30.444041Z","steps":["trace[162155705] 'agreement among raft nodes before linearized reading' (duration: 115.549295ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T11:03:40.309549Z","caller":"traceutil/trace.go:171","msg":"trace[1300068454] linearizableReadLoop","detail":"{readStateIndex:4877; appliedIndex:4876; }","duration":"110.84052ms","start":"2026-07-01T11:03:40.198683Z","end":"2026-07-01T11:03:40.309523Z","steps":["trace[1300068454] 'read index received' (duration: 110.618386ms)","trace[1300068454] 'applied index is now lower than readState.Index' (duration: 220.744µs)"],"step_count":2} {"level":"warn","ts":"2026-07-01T11:03:40.309784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.078413ms","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":"info","ts":"2026-07-01T11:03:40.309827Z","caller":"traceutil/trace.go:171","msg":"trace[736569948] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:4697; }","duration":"111.167645ms","start":"2026-07-01T11:03:40.198647Z","end":"2026-07-01T11:03:40.309815Z","steps":["trace[736569948] 'agreement among raft nodes before linearized reading' (duration: 110.979991ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T11:03:40.310008Z","caller":"traceutil/trace.go:171","msg":"trace[1125164515] transaction","detail":"{read_only:false; response_revision:4697; number_of_response:1; }","duration":"123.981808ms","start":"2026-07-01T11:03:40.185989Z","end":"2026-07-01T11:03:40.309971Z","steps":["trace[1125164515] 'process raft request' (duration: 123.366648ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T11:03:45.133335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.579369ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T11:03:45.133531Z","caller":"traceutil/trace.go:171","msg":"trace[1926496229] linearizableReadLoop","detail":"{readStateIndex:4962; appliedIndex:4961; }","duration":"319.611616ms","start":"2026-07-01T11:03:44.813894Z","end":"2026-07-01T11:03:45.133506Z","steps":["trace[1926496229] 'read index received' (duration: 112.827474ms)","trace[1926496229] 'applied index is now lower than readState.Index' (duration: 206.782232ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T11:03:45.133587Z","caller":"traceutil/trace.go:171","msg":"trace[699609453] transaction","detail":"{read_only:false; response_revision:4781; number_of_response:1; }","duration":"337.252167ms","start":"2026-07-01T11:03:44.796298Z","end":"2026-07-01T11:03:45.13355Z","steps":["trace[699609453] 'process raft request' (duration: 130.346313ms)","trace[699609453] 'compare' (duration: 206.249364ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T11:03:45.134236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T11:03:44.796266Z","time spent":"337.810357ms","remote":"127.0.0.1:40292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T11:03:45.134364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.46348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T11:03:45.134449Z","caller":"traceutil/trace.go:171","msg":"trace[137060980] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4781; }","duration":"320.570001ms","start":"2026-07-01T11:03:44.813865Z","end":"2026-07-01T11:03:45.134435Z","steps":["trace[137060980] 'agreement among raft nodes before linearized reading' (duration: 319.83274ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T11:03:45.134552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T11:03:44.813829Z","time spent":"320.680924ms","remote":"127.0.0.1:40010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-01T11:03:45.13627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.197684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6af56a5f-3669-4567-8642-57c7dad1040f\" ","response":"range_response_count:1 size:3762"} {"level":"info","ts":"2026-07-01T11:03:45.136364Z","caller":"traceutil/trace.go:171","msg":"trace[1094176548] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6af56a5f-3669-4567-8642-57c7dad1040f; range_end:; response_count:1; response_revision:4781; }","duration":"203.350115ms","start":"2026-07-01T11:03:44.932996Z","end":"2026-07-01T11:03:45.136346Z","steps":["trace[1094176548] 'agreement among raft nodes before linearized reading' (duration: 200.996186ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T11:03:58.94654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.569007ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T11:03:58.946667Z","caller":"traceutil/trace.go:171","msg":"trace[581170355] linearizableReadLoop","detail":"{readStateIndex:5144; appliedIndex:5143; }","duration":"408.930007ms","start":"2026-07-01T11:03:58.53772Z","end":"2026-07-01T11:03:58.94665Z","steps":["trace[581170355] 'read index received' (duration: 247.032105ms)","trace[581170355] 'applied index is now lower than readState.Index' (duration: 161.896552ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T11:03:58.946983Z","caller":"traceutil/trace.go:171","msg":"trace[1900121637] transaction","detail":"{read_only:false; response_revision:4958; number_of_response:1; }","duration":"418.370329ms","start":"2026-07-01T11:03:58.528573Z","end":"2026-07-01T11:03:58.946944Z","steps":["trace[1900121637] 'process raft request' (duration: 256.251423ms)","trace[1900121637] 'compare' (duration: 161.255112ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T11:03:58.947166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.889435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10391"} {"level":"info","ts":"2026-07-01T11:03:58.947211Z","caller":"traceutil/trace.go:171","msg":"trace[1966573258] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4958; }","duration":"120.972737ms","start":"2026-07-01T11:03:58.826225Z","end":"2026-07-01T11:03:58.947197Z","steps":["trace[1966573258] 'agreement among raft nodes before linearized reading' (duration: 120.785894ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T11:03:58.947178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.443646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"} {"level":"warn","ts":"2026-07-01T11:03:58.947229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T11:03:58.528537Z","time spent":"418.570272ms","remote":"127.0.0.1:40292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T11:03:58.9473Z","caller":"traceutil/trace.go:171","msg":"trace[2089708322] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4958; }","duration":"409.602138ms","start":"2026-07-01T11:03:58.537647Z","end":"2026-07-01T11:03:58.947249Z","steps":["trace[2089708322] 'agreement among raft nodes before linearized reading' (duration: 409.206922ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T11:03:58.947371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T11:03:58.537612Z","time spent":"409.74183ms","remote":"127.0.0.1:41282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3266,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"info","ts":"2026-07-01T11:03:59.144432Z","caller":"traceutil/trace.go:171","msg":"trace[1715822724] transaction","detail":"{read_only:false; response_revision:4962; number_of_response:1; }","duration":"115.617587ms","start":"2026-07-01T11:03:59.028773Z","end":"2026-07-01T11:03:59.14439Z","steps":["trace[1715822724] 'process raft request' (duration: 23.701189ms)","trace[1715822724] 'compare' (duration: 91.575423ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T11:03:59.144473Z","caller":"traceutil/trace.go:171","msg":"trace[68570037] transaction","detail":"{read_only:false; response_revision:4963; number_of_response:1; }","duration":"115.296002ms","start":"2026-07-01T11:03:59.029135Z","end":"2026-07-01T11:03:59.144431Z","steps":["trace[68570037] 'process raft request' (duration: 115.117769ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T11:03:59.144498Z","caller":"traceutil/trace.go:171","msg":"trace[1228638584] transaction","detail":"{read_only:false; response_revision:4964; number_of_response:1; }","duration":"115.272361ms","start":"2026-07-01T11:03:59.029184Z","end":"2026-07-01T11:03:59.144456Z","steps":["trace[1228638584] 'process raft request' (duration: 115.156449ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T11:03:59.144867Z","caller":"traceutil/trace.go:171","msg":"trace[646163158] transaction","detail":"{read_only:false; response_revision:4965; number_of_response:1; }","duration":"115.493466ms","start":"2026-07-01T11:03:59.029349Z","end":"2026-07-01T11:03:59.144842Z","steps":["trace[646163158] 'process raft request' (duration: 115.028278ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T11:04:38.672776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.145024ms","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:4725"} {"level":"info","ts":"2026-07-01T11:04:38.672879Z","caller":"traceutil/trace.go:171","msg":"trace[18257117] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:5321; }","duration":"106.293725ms","start":"2026-07-01T11:04:38.566558Z","end":"2026-07-01T11:04:38.672852Z","steps":["trace[18257117] 'range keys from in-memory index tree' (duration: 105.923ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T11:04:50.302776Z","caller":"traceutil/trace.go:171","msg":"trace[1949649361] transaction","detail":"{read_only:false; response_revision:5408; number_of_response:1; }","duration":"128.167672ms","start":"2026-07-01T11:04:50.174584Z","end":"2026-07-01T11:04:50.302752Z","steps":["trace[1949649361] 'process raft request' (duration: 128.03236ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T11:05:16.144444Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2911} {"level":"info","ts":"2026-07-01T11:05:16.244386Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2911,"took":"98.337596ms","hash":1890367073,"current-db-size-bytes":53604352,"current-db-size":"54 MB","current-db-size-in-use-bytes":29085696,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-01T11:05:16.244456Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1890367073,"revision":2911,"compact-revision":-1} {"level":"info","ts":"2026-07-01T11:08:05.061928Z","caller":"traceutil/trace.go:171","msg":"trace[1702301413] transaction","detail":"{read_only:false; response_revision:6768; number_of_response:1; }","duration":"127.708623ms","start":"2026-07-01T11:08:04.934198Z","end":"2026-07-01T11:08:05.061907Z","steps":["trace[1702301413] 'process raft request' (duration: 127.517591ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T11:10:16.15526Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5604} {"level":"info","ts":"2026-07-01T11:10:16.257213Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5604,"took":"99.6156ms","hash":999974770,"current-db-size-bytes":53604352,"current-db-size":"54 MB","current-db-size-in-use-bytes":18530304,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-01T11:10:16.257341Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":999974770,"revision":5604,"compact-revision":2911}