{"level":"warn","ts":"2026-06-16T00:27:30.72008Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-16T00:27:30.720227Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.129:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.129:2380","--initial-cluster=instance=https://199.19.213.129:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.129:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.129: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-06-16T00:27:30.720332Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-16T00:27:30.720351Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.129:2380"]} {"level":"info","ts":"2026-06-16T00:27:30.72038Z","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-06-16T00:27:30.721215Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.129:2379"]} {"level":"info","ts":"2026-06-16T00:27:30.721308Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.129:2380"],"listen-peer-urls":["https://199.19.213.129:2380"],"advertise-client-urls":["https://199.19.213.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.129: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-06-16T00:27:30.725113Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.542898ms"} {"level":"info","ts":"2026-06-16T00:27:30.733504Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d319cd7bf0a1887b","cluster-id":"2ab213cc48e2c85a"} {"level":"info","ts":"2026-06-16T00:27:30.733587Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d319cd7bf0a1887b switched to configuration voters=()"} {"level":"info","ts":"2026-06-16T00:27:30.733641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d319cd7bf0a1887b became follower at term 0"} {"level":"info","ts":"2026-06-16T00:27:30.733654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d319cd7bf0a1887b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-16T00:27:30.733662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d319cd7bf0a1887b became follower at term 1"} {"level":"info","ts":"2026-06-16T00:27:30.733725Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d319cd7bf0a1887b switched to configuration voters=(15211415148622350459)"} {"level":"warn","ts":"2026-06-16T00:27:30.749838Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-16T00:27:30.767161Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-16T00:27:30.780068Z","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-06-16T00:27:30.784615Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d319cd7bf0a1887b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-16T00:27:30.785183Z","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-06-16T00:27:30.785288Z","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-06-16T00:27:30.785298Z","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-06-16T00:27:30.785251Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d319cd7bf0a1887b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-16T00:27:30.790666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d319cd7bf0a1887b switched to configuration voters=(15211415148622350459)"} {"level":"info","ts":"2026-06-16T00:27:30.790974Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2ab213cc48e2c85a","local-member-id":"d319cd7bf0a1887b","added-peer-id":"d319cd7bf0a1887b","added-peer-peer-urls":["https://199.19.213.129:2380"]} {"level":"info","ts":"2026-06-16T00:27:30.793027Z","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-06-16T00:27:30.793226Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.129:2380"} {"level":"info","ts":"2026-06-16T00:27:30.793295Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.129:2380"} {"level":"info","ts":"2026-06-16T00:27:30.793404Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d319cd7bf0a1887b","initial-advertise-peer-urls":["https://199.19.213.129:2380"],"listen-peer-urls":["https://199.19.213.129:2380"],"advertise-client-urls":["https://199.19.213.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-16T00:27:30.793506Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-16T00:27:31.134795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d319cd7bf0a1887b is starting a new election at term 1"} {"level":"info","ts":"2026-06-16T00:27:31.134969Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d319cd7bf0a1887b became pre-candidate at term 1"} {"level":"info","ts":"2026-06-16T00:27:31.135098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d319cd7bf0a1887b received MsgPreVoteResp from d319cd7bf0a1887b at term 1"} {"level":"info","ts":"2026-06-16T00:27:31.135133Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d319cd7bf0a1887b became candidate at term 2"} {"level":"info","ts":"2026-06-16T00:27:31.135189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d319cd7bf0a1887b received MsgVoteResp from d319cd7bf0a1887b at term 2"} {"level":"info","ts":"2026-06-16T00:27:31.13521Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d319cd7bf0a1887b became leader at term 2"} {"level":"info","ts":"2026-06-16T00:27:31.135298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d319cd7bf0a1887b elected leader d319cd7bf0a1887b at term 2"} {"level":"info","ts":"2026-06-16T00:27:31.13643Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T00:27:31.137209Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-16T00:27:31.137188Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d319cd7bf0a1887b","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.129:2379]}","request-path":"/0/members/d319cd7bf0a1887b/attributes","cluster-id":"2ab213cc48e2c85a","publish-timeout":"7s"} {"level":"info","ts":"2026-06-16T00:27:31.137423Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-16T00:27:31.137601Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2ab213cc48e2c85a","local-member-id":"d319cd7bf0a1887b","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T00:27:31.137821Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T00:27:31.137758Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-16T00:27:31.137875Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T00:27:31.137939Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-16T00:27:31.142306Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.129:2379"} {"level":"info","ts":"2026-06-16T00:27:31.142495Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-16T00:27:43.847107Z","caller":"traceutil/trace.go:171","msg":"trace[499638168] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"138.189104ms","start":"2026-06-16T00:27:43.708898Z","end":"2026-06-16T00:27:43.847087Z","steps":["trace[499638168] 'process raft request' (duration: 138.054233ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:27:44.128774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.511472ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T00:27:44.129004Z","caller":"traceutil/trace.go:171","msg":"trace[1460941610] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"244.613465ms","start":"2026-06-16T00:27:43.884348Z","end":"2026-06-16T00:27:44.128961Z","steps":["trace[1460941610] 'process raft request' (duration: 105.512615ms)","trace[1460941610] 'compare' (duration: 138.424481ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:27:44.412219Z","caller":"traceutil/trace.go:171","msg":"trace[535957258] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"182.751838ms","start":"2026-06-16T00:27:44.229434Z","end":"2026-06-16T00:27:44.412186Z","steps":["trace[535957258] 'process raft request' (duration: 89.397034ms)","trace[535957258] 'compare' (duration: 93.202382ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:28:12.326046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.265141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-j7kb6\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-16T00:28:12.326137Z","caller":"traceutil/trace.go:171","msg":"trace[2037663455] range","detail":"{range_begin:/registry/pods/kube-system/cilium-j7kb6; range_end:; response_count:1; response_revision:585; }","duration":"401.360923ms","start":"2026-06-16T00:28:11.924748Z","end":"2026-06-16T00:28:12.326109Z","steps":["trace[2037663455] 'range keys from in-memory index tree' (duration: 401.15566ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:28:12.326181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:28:11.924734Z","time spent":"401.437173ms","remote":"127.0.0.1:45336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-j7kb6\" "} {"level":"warn","ts":"2026-06-16T00:28:12.325927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.141934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-16T00:28:12.326804Z","caller":"traceutil/trace.go:171","msg":"trace[1500382655] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:585; }","duration":"305.056024ms","start":"2026-06-16T00:28:12.021718Z","end":"2026-06-16T00:28:12.326774Z","steps":["trace[1500382655] 'range keys from in-memory index tree' (duration: 303.946501ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:28:12.326903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:28:12.021703Z","time spent":"305.159715ms","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-16T00:28:12.328746Z","caller":"traceutil/trace.go:171","msg":"trace[611404190] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:608; }","duration":"100.97447ms","start":"2026-06-16T00:28:12.227732Z","end":"2026-06-16T00:28:12.328706Z","steps":["trace[611404190] 'read index received' (duration: 55.730566ms)","trace[611404190] 'applied index is now lower than readState.Index' (duration: 45.242654ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:28:12.32893Z","caller":"traceutil/trace.go:171","msg":"trace[340979847] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"121.292235ms","start":"2026-06-16T00:28:12.207624Z","end":"2026-06-16T00:28:12.328916Z","steps":["trace[340979847] 'process raft request' (duration: 76.680058ms)","trace[340979847] 'compare' (duration: 43.391843ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:28:12.329445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.703778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:28:12.329485Z","caller":"traceutil/trace.go:171","msg":"trace[1957574258] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:586; }","duration":"101.806379ms","start":"2026-06-16T00:28:12.227668Z","end":"2026-06-16T00:28:12.329474Z","steps":["trace[1957574258] 'agreement among raft nodes before linearized reading' (duration: 101.714378ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:28:12.803158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.459844ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T00:28:12.803349Z","caller":"traceutil/trace.go:171","msg":"trace[883859277] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"466.703636ms","start":"2026-06-16T00:28:12.336618Z","end":"2026-06-16T00:28:12.803321Z","steps":["trace[883859277] 'process raft request' (duration: 270.999759ms)","trace[883859277] 'compare' (duration: 195.14875ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:28:12.8035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:28:12.336606Z","time spent":"466.823069ms","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T00:28:12.803734Z","caller":"traceutil/trace.go:171","msg":"trace[1991232392] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"451.657423ms","start":"2026-06-16T00:28:12.352058Z","end":"2026-06-16T00:28:12.803716Z","steps":["trace[1991232392] 'process raft request' (duration: 451.244727ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:28:12.80385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:28:12.35204Z","time spent":"451.765434ms","remote":"127.0.0.1:45336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T00:28:12.803888Z","caller":"traceutil/trace.go:171","msg":"trace[187180327] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"464.050616ms","start":"2026-06-16T00:28:12.339825Z","end":"2026-06-16T00:28:12.803875Z","steps":["trace[187180327] 'process raft request' (duration: 463.422378ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:28:12.80395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:28:12.339811Z","time spent":"464.105786ms","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T00:28:12.803844Z","caller":"traceutil/trace.go:171","msg":"trace[1204331271] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"391.707518ms","start":"2026-06-16T00:28:12.412095Z","end":"2026-06-16T00:28:12.803802Z","steps":["trace[1204331271] 'process raft request' (duration: 391.251173ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:28:12.80461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:28:12.41207Z","time spent":"392.450696ms","remote":"127.0.0.1:45372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-16T00:29:43.362898Z","caller":"traceutil/trace.go:171","msg":"trace[1210141275] linearizableReadLoop","detail":"{readStateIndex:1886; appliedIndex:1885; }","duration":"100.209631ms","start":"2026-06-16T00:29:43.262665Z","end":"2026-06-16T00:29:43.362875Z","steps":["trace[1210141275] 'read index received' (duration: 100.094508ms)","trace[1210141275] 'applied index is now lower than readState.Index' (duration: 114.373µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:29:43.362951Z","caller":"traceutil/trace.go:171","msg":"trace[629893964] transaction","detail":"{read_only:false; response_revision:1816; number_of_response:1; }","duration":"103.775984ms","start":"2026-06-16T00:29:43.259155Z","end":"2026-06-16T00:29:43.362931Z","steps":["trace[629893964] 'process raft request' (duration: 103.595959ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:29:43.363118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.439998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-16T00:29:43.36321Z","caller":"traceutil/trace.go:171","msg":"trace[15690162] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1816; }","duration":"100.603461ms","start":"2026-06-16T00:29:43.262584Z","end":"2026-06-16T00:29:43.363187Z","steps":["trace[15690162] 'agreement among raft nodes before linearized reading' (duration: 100.384686ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:29:43.470329Z","caller":"traceutil/trace.go:171","msg":"trace[1506015436] transaction","detail":"{read_only:false; response_revision:1818; number_of_response:1; }","duration":"102.658135ms","start":"2026-06-16T00:29:43.367643Z","end":"2026-06-16T00:29:43.470302Z","steps":["trace[1506015436] 'process raft request' (duration: 102.446679ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:29:43.470373Z","caller":"traceutil/trace.go:171","msg":"trace[459179616] transaction","detail":"{read_only:false; response_revision:1819; number_of_response:1; }","duration":"101.72069ms","start":"2026-06-16T00:29:43.368626Z","end":"2026-06-16T00:29:43.470346Z","steps":["trace[459179616] 'process raft request' (duration: 101.595627ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:29:57.967021Z","caller":"traceutil/trace.go:171","msg":"trace[1670600658] transaction","detail":"{read_only:false; response_revision:1936; number_of_response:1; }","duration":"134.319461ms","start":"2026-06-16T00:29:57.832686Z","end":"2026-06-16T00:29:57.967006Z","steps":["trace[1670600658] 'process raft request' (duration: 134.221938ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:29:57.96914Z","caller":"traceutil/trace.go:171","msg":"trace[1257452053] transaction","detail":"{read_only:false; response_revision:1937; number_of_response:1; }","duration":"106.313309ms","start":"2026-06-16T00:29:57.862812Z","end":"2026-06-16T00:29:57.969126Z","steps":["trace[1257452053] 'process raft request' (duration: 105.938939ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:30:15.374601Z","caller":"traceutil/trace.go:171","msg":"trace[975797103] transaction","detail":"{read_only:false; response_revision:2040; number_of_response:1; }","duration":"105.403456ms","start":"2026-06-16T00:30:15.269175Z","end":"2026-06-16T00:30:15.374578Z","steps":["trace[975797103] 'process raft request' (duration: 105.283383ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:30:20.766282Z","caller":"traceutil/trace.go:171","msg":"trace[578426979] transaction","detail":"{read_only:false; response_revision:2072; number_of_response:1; }","duration":"151.589996ms","start":"2026-06-16T00:30:20.614668Z","end":"2026-06-16T00:30:20.766258Z","steps":["trace[578426979] 'process raft request' (duration: 115.890284ms)","trace[578426979] 'compare' (duration: 35.583809ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:30:21.00501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.310785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:30:21.00512Z","caller":"traceutil/trace.go:171","msg":"trace[417630698] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2072; }","duration":"126.487708ms","start":"2026-06-16T00:30:20.878594Z","end":"2026-06-16T00:30:21.005082Z","steps":["trace[417630698] 'count revisions from in-memory index tree' (duration: 126.174502ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:30:22.025442Z","caller":"traceutil/trace.go:171","msg":"trace[1314616915] transaction","detail":"{read_only:false; response_revision:2077; number_of_response:1; }","duration":"295.638038ms","start":"2026-06-16T00:30:21.729765Z","end":"2026-06-16T00:30:22.025403Z","steps":["trace[1314616915] 'process raft request' (duration: 295.533476ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:30:22.025463Z","caller":"traceutil/trace.go:171","msg":"trace[1594249478] transaction","detail":"{read_only:false; response_revision:2076; number_of_response:1; }","duration":"295.845922ms","start":"2026-06-16T00:30:21.729563Z","end":"2026-06-16T00:30:22.025409Z","steps":["trace[1594249478] 'process raft request' (duration: 295.578196ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:30:22.025804Z","caller":"traceutil/trace.go:171","msg":"trace[159670395] transaction","detail":"{read_only:false; response_revision:2078; number_of_response:1; }","duration":"268.930566ms","start":"2026-06-16T00:30:21.756841Z","end":"2026-06-16T00:30:22.025772Z","steps":["trace[159670395] 'process raft request' (duration: 268.514947ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:30:22.026054Z","caller":"traceutil/trace.go:171","msg":"trace[980158747] linearizableReadLoop","detail":"{readStateIndex:2157; appliedIndex:2154; }","duration":"128.016731ms","start":"2026-06-16T00:30:21.898017Z","end":"2026-06-16T00:30:22.026034Z","steps":["trace[980158747] 'read index received' (duration: 127.116251ms)","trace[980158747] 'applied index is now lower than readState.Index' (duration: 897.91µs)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:30:22.026233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.198764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1990"} {"level":"info","ts":"2026-06-16T00:30:22.026318Z","caller":"traceutil/trace.go:171","msg":"trace[957182086] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2078; }","duration":"128.323587ms","start":"2026-06-16T00:30:21.89797Z","end":"2026-06-16T00:30:22.026294Z","steps":["trace[957182086] 'agreement among raft nodes before linearized reading' (duration: 128.130433ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:30:22.279805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.851834ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T00:30:22.279936Z","caller":"traceutil/trace.go:171","msg":"trace[1362124716] linearizableReadLoop","detail":"{readStateIndex:2159; appliedIndex:2158; }","duration":"155.322574ms","start":"2026-06-16T00:30:22.124593Z","end":"2026-06-16T00:30:22.279916Z","steps":["trace[1362124716] 'read index received' (duration: 9.140722ms)","trace[1362124716] 'applied index is now lower than readState.Index' (duration: 146.180572ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:30:22.279953Z","caller":"traceutil/trace.go:171","msg":"trace[2124539088] transaction","detail":"{read_only:false; response_revision:2080; number_of_response:1; }","duration":"227.31135ms","start":"2026-06-16T00:30:22.052607Z","end":"2026-06-16T00:30:22.279918Z","steps":["trace[2124539088] 'process raft request' (duration: 81.137588ms)","trace[2124539088] 'compare' (duration: 145.666661ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:30:22.280174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.585549ms","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-06-16T00:30:22.280217Z","caller":"traceutil/trace.go:171","msg":"trace[1580593022] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2080; }","duration":"155.660031ms","start":"2026-06-16T00:30:22.124545Z","end":"2026-06-16T00:30:22.280205Z","steps":["trace[1580593022] 'agreement among raft nodes before linearized reading' (duration: 155.486687ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:30:22.280416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.231409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-06-16T00:30:22.280508Z","caller":"traceutil/trace.go:171","msg":"trace[2120046556] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2080; }","duration":"154.371132ms","start":"2026-06-16T00:30:22.12611Z","end":"2026-06-16T00:30:22.280481Z","steps":["trace[2120046556] 'agreement among raft nodes before linearized reading' (duration: 154.106006ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:31:22.444141Z","caller":"traceutil/trace.go:171","msg":"trace[1105517929] transaction","detail":"{read_only:false; response_revision:2506; number_of_response:1; }","duration":"139.424575ms","start":"2026-06-16T00:31:22.304652Z","end":"2026-06-16T00:31:22.444077Z","steps":["trace[1105517929] 'process raft request' (duration: 138.936475ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:31:22.444591Z","caller":"traceutil/trace.go:171","msg":"trace[492056701] transaction","detail":"{read_only:false; response_revision:2507; number_of_response:1; }","duration":"139.896093ms","start":"2026-06-16T00:31:22.304676Z","end":"2026-06-16T00:31:22.444572Z","steps":["trace[492056701] 'process raft request' (duration: 139.679369ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:31:54.821834Z","caller":"traceutil/trace.go:171","msg":"trace[774699970] transaction","detail":"{read_only:false; response_revision:2685; number_of_response:1; }","duration":"164.30901ms","start":"2026-06-16T00:31:54.657495Z","end":"2026-06-16T00:31:54.821804Z","steps":["trace[774699970] 'process raft request' (duration: 110.890796ms)","trace[774699970] 'compare' (duration: 53.311712ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:31:54.860106Z","caller":"traceutil/trace.go:171","msg":"trace[331368792] linearizableReadLoop","detail":"{readStateIndex:2787; appliedIndex:2785; }","duration":"144.781847ms","start":"2026-06-16T00:31:54.715304Z","end":"2026-06-16T00:31:54.860086Z","steps":["trace[331368792] 'read index received' (duration: 53.083729ms)","trace[331368792] 'applied index is now lower than readState.Index' (duration: 91.697058ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:31:54.860565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.239754ms","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-06-16T00:31:54.861027Z","caller":"traceutil/trace.go:171","msg":"trace[2101506936] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2686; }","duration":"145.762433ms","start":"2026-06-16T00:31:54.715248Z","end":"2026-06-16T00:31:54.86101Z","steps":["trace[2101506936] 'agreement among raft nodes before linearized reading' (duration: 145.077912ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:31:54.860563Z","caller":"traceutil/trace.go:171","msg":"trace[895297162] transaction","detail":"{read_only:false; response_revision:2686; number_of_response:1; }","duration":"202.920499ms","start":"2026-06-16T00:31:54.657613Z","end":"2026-06-16T00:31:54.860533Z","steps":["trace[895297162] 'process raft request' (duration: 201.826872ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:16.763375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.856519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:32:16.763469Z","caller":"traceutil/trace.go:171","msg":"trace[875462748] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:2797; }","duration":"398.006412ms","start":"2026-06-16T00:32:16.365444Z","end":"2026-06-16T00:32:16.763451Z","steps":["trace[875462748] 'count revisions from in-memory index tree' (duration: 397.760458ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:16.763512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:16.365428Z","time spent":"398.073083ms","remote":"127.0.0.1:48970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-16T00:32:16.763654Z","caller":"traceutil/trace.go:171","msg":"trace[184895331] transaction","detail":"{read_only:false; response_revision:2798; number_of_response:1; }","duration":"247.612385ms","start":"2026-06-16T00:32:16.515991Z","end":"2026-06-16T00:32:16.763604Z","steps":["trace[184895331] 'process raft request' (duration: 246.972365ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:23.452601Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9834628818147493206,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-16T00:32:23.952902Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9834628818147493206,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-16T00:32:24.453359Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9834628818147493206,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-16T00:32:24.953838Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9834628818147493206,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-16T00:32:25.45481Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9834628818147493206,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-16T00:32:25.955131Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9834628818147493206,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-16T00:32:26.228336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.99991312s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-06-16T00:32:26.228425Z","caller":"traceutil/trace.go:171","msg":"trace[1356903793] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000058362s","start":"2026-06-16T00:32:24.228345Z","end":"2026-06-16T00:32:26.228403Z","steps":["trace[1356903793] 'agreement among raft nodes before linearized reading' (duration: 1.99993967s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:26.228477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:24.228326Z","time spent":"2.000141723s","remote":"127.0.0.1:45182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/16 00:32:26 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-16T00:32:26.455728Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9834628818147493206,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-16T00:32:26.956427Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9834628818147493206,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-16T00:32:27.20329Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"4.418625431s","expected-duration":"1s"} {"level":"info","ts":"2026-06-16T00:32:27.208106Z","caller":"traceutil/trace.go:171","msg":"trace[307027143] transaction","detail":"{read_only:false; response_revision:2831; number_of_response:1; }","duration":"4.423598106s","start":"2026-06-16T00:32:22.784487Z","end":"2026-06-16T00:32:27.208085Z","steps":["trace[307027143] 'process raft request' (duration: 4.418949495s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:27.20821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:22.784461Z","time spent":"4.423692258s","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T00:32:27.208453Z","caller":"traceutil/trace.go:171","msg":"trace[722019392] linearizableReadLoop","detail":"{readStateIndex:2939; appliedIndex:2936; }","duration":"4.256262686s","start":"2026-06-16T00:32:22.952179Z","end":"2026-06-16T00:32:27.208441Z","steps":["trace[722019392] 'read index received' (duration: 4.251270021s)","trace[722019392] 'applied index is now lower than readState.Index' (duration: 4.991835ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:32:27.20856Z","caller":"traceutil/trace.go:171","msg":"trace[1135097684] transaction","detail":"{read_only:false; response_revision:2832; number_of_response:1; }","duration":"4.423521246s","start":"2026-06-16T00:32:22.785031Z","end":"2026-06-16T00:32:27.208552Z","steps":["trace[1135097684] 'process raft request' (duration: 4.423296652s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:27.208821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.256636334s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-16T00:32:27.208879Z","caller":"traceutil/trace.go:171","msg":"trace[1490535749] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2833; }","duration":"4.256729555s","start":"2026-06-16T00:32:22.952132Z","end":"2026-06-16T00:32:27.208862Z","steps":["trace[1490535749] 'agreement among raft nodes before linearized reading' (duration: 4.256577113s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:27.208912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:22.952115Z","time spent":"4.256787645s","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-16T00:32:27.209313Z","caller":"traceutil/trace.go:171","msg":"trace[1138017798] transaction","detail":"{read_only:false; response_revision:2833; number_of_response:1; }","duration":"4.009768465s","start":"2026-06-16T00:32:23.199526Z","end":"2026-06-16T00:32:27.209294Z","steps":["trace[1138017798] 'process raft request' (duration: 4.008872911s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:27.209402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:23.199501Z","time spent":"4.009845766s","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T00:32:27.209433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.2223088s","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-06-16T00:32:27.209513Z","caller":"traceutil/trace.go:171","msg":"trace[905905115] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2833; }","duration":"4.222417351s","start":"2026-06-16T00:32:22.987075Z","end":"2026-06-16T00:32:27.209492Z","steps":["trace[905905115] 'agreement among raft nodes before linearized reading' (duration: 4.222204828s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:27.209542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.865249555s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-06-16T00:32:27.209557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:22.987063Z","time spent":"4.222483922s","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-16T00:32:27.209567Z","caller":"traceutil/trace.go:171","msg":"trace[1600776901] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2833; }","duration":"2.865318106s","start":"2026-06-16T00:32:24.344241Z","end":"2026-06-16T00:32:27.209559Z","steps":["trace[1600776901] 'agreement among raft nodes before linearized reading' (duration: 2.865237825s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:27.209591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:24.344217Z","time spent":"2.865368327s","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-16T00:32:27.20965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.383889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:32:27.209693Z","caller":"traceutil/trace.go:171","msg":"trace[1660610198] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:2833; }","duration":"272.44662ms","start":"2026-06-16T00:32:26.937216Z","end":"2026-06-16T00:32:27.209663Z","steps":["trace[1660610198] 'agreement among raft nodes before linearized reading' (duration: 272.414089ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:27.209726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.880111625s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-16T00:32:27.209758Z","caller":"traceutil/trace.go:171","msg":"trace[1834944116] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2833; }","duration":"2.880183106s","start":"2026-06-16T00:32:24.329565Z","end":"2026-06-16T00:32:27.209748Z","steps":["trace[1834944116] 'agreement among raft nodes before linearized reading' (duration: 2.880082585s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:27.209785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:24.329542Z","time spent":"2.880236767s","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-16T00:32:27.209878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.223457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-16T00:32:27.209902Z","caller":"traceutil/trace.go:171","msg":"trace[1609479865] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:2833; }","duration":"483.282208ms","start":"2026-06-16T00:32:26.726614Z","end":"2026-06-16T00:32:27.209896Z","steps":["trace[1609479865] 'agreement among raft nodes before linearized reading' (duration: 483.197437ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:27.209921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:26.726595Z","time spent":"483.320959ms","remote":"127.0.0.1:45460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":90,"response size":30,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"warn","ts":"2026-06-16T00:32:27.209936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.071374073s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.129\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-16T00:32:27.209975Z","caller":"traceutil/trace.go:171","msg":"trace[944576543] range","detail":"{range_begin:/registry/masterleases/199.19.213.129; range_end:; response_count:1; response_revision:2833; }","duration":"3.071440324s","start":"2026-06-16T00:32:24.138523Z","end":"2026-06-16T00:32:27.209963Z","steps":["trace[944576543] 'agreement among raft nodes before linearized reading' (duration: 3.071339743s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:27.210012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:24.138498Z","time spent":"3.071505985s","remote":"127.0.0.1:45202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.129\" "} {"level":"warn","ts":"2026-06-16T00:32:27.210027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"981.310279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:32:27.210045Z","caller":"traceutil/trace.go:171","msg":"trace[1174273517] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2833; }","duration":"981.36176ms","start":"2026-06-16T00:32:26.228677Z","end":"2026-06-16T00:32:27.210039Z","steps":["trace[1174273517] 'agreement among raft nodes before linearized reading' (duration: 981.33288ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:27.210062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:26.228657Z","time spent":"981.399171ms","remote":"127.0.0.1:45186","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-06-16T00:32:27.210154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.507361733s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:32:27.210172Z","caller":"traceutil/trace.go:171","msg":"trace[1797683719] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:2833; }","duration":"1.507413593s","start":"2026-06-16T00:32:25.702753Z","end":"2026-06-16T00:32:27.210166Z","steps":["trace[1797683719] 'agreement among raft nodes before linearized reading' (duration: 1.507383983s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:27.210186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:25.70273Z","time spent":"1.507451675s","remote":"127.0.0.1:48770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-06-16T00:32:27.21033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.908224511s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18b9686045d4cc1c\" ","response":"range_response_count:1 size:777"} {"level":"info","ts":"2026-06-16T00:32:27.210344Z","caller":"traceutil/trace.go:171","msg":"trace[162824392] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18b9686045d4cc1c; range_end:; response_count:1; response_revision:2833; }","duration":"1.908292711s","start":"2026-06-16T00:32:25.302047Z","end":"2026-06-16T00:32:27.21034Z","steps":["trace[162824392] 'agreement among raft nodes before linearized reading' (duration: 1.90823791s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:27.210357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:25.302018Z","time spent":"1.908336072s","remote":"127.0.0.1:45244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":800,"request content":"key:\"/registry/events/auth-system/keycloak-0.18b9686045d4cc1c\" "} {"level":"warn","ts":"2026-06-16T00:32:27.210353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.187267217s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-16T00:32:27.210404Z","caller":"traceutil/trace.go:171","msg":"trace[1350339677] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2833; }","duration":"3.187359978s","start":"2026-06-16T00:32:24.023031Z","end":"2026-06-16T00:32:27.210391Z","steps":["trace[1350339677] 'agreement among raft nodes before linearized reading' (duration: 3.187158015s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:27.210434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.486780671s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:32:27.210449Z","caller":"traceutil/trace.go:171","msg":"trace[1099512311] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:2833; }","duration":"2.486834363s","start":"2026-06-16T00:32:24.723609Z","end":"2026-06-16T00:32:27.210443Z","steps":["trace[1099512311] 'agreement among raft nodes before linearized reading' (duration: 2.486809472s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:27.210442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:24.023006Z","time spent":"3.187426399s","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-16T00:32:27.210463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:24.72359Z","time spent":"2.486869563s","remote":"127.0.0.1:59998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"warn","ts":"2026-06-16T00:32:27.210537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.811592995s","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-06-16T00:32:27.21055Z","caller":"traceutil/trace.go:171","msg":"trace[745256523] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2833; }","duration":"2.811631035s","start":"2026-06-16T00:32:24.398915Z","end":"2026-06-16T00:32:27.210546Z","steps":["trace[745256523] 'agreement among raft nodes before linearized reading' (duration: 2.811606495s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:27.210562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:24.398899Z","time spent":"2.811659295s","remote":"127.0.0.1:48838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-06-16T00:32:27.210616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.219347142s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-06-16T00:32:27.210651Z","caller":"traceutil/trace.go:171","msg":"trace[1406010222] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2833; }","duration":"3.219381303s","start":"2026-06-16T00:32:23.991259Z","end":"2026-06-16T00:32:27.210641Z","steps":["trace[1406010222] 'agreement among raft nodes before linearized reading' (duration: 3.219268501s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:27.21069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:23.9912Z","time spent":"3.219477104s","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1392,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"warn","ts":"2026-06-16T00:32:27.210964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.273158486s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-06-16T00:32:27.211007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.214013891s","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-06-16T00:32:27.21101Z","caller":"traceutil/trace.go:171","msg":"trace[808622896] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2833; }","duration":"3.273246227s","start":"2026-06-16T00:32:23.937754Z","end":"2026-06-16T00:32:27.211Z","steps":["trace[808622896] 'agreement among raft nodes before linearized reading' (duration: 3.273117385s)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:32:27.211026Z","caller":"traceutil/trace.go:171","msg":"trace[345747411] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2833; }","duration":"4.214052931s","start":"2026-06-16T00:32:22.996967Z","end":"2026-06-16T00:32:27.21102Z","steps":["trace[345747411] 'agreement among raft nodes before linearized reading' (duration: 4.21399459s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:27.21104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:22.996957Z","time spent":"4.214080631s","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-06-16T00:32:27.21104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:23.937735Z","time spent":"3.273298608s","remote":"127.0.0.1:45336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-16T00:32:27.211082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.484520632s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:32:27.211094Z","caller":"traceutil/trace.go:171","msg":"trace[82269303] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:2833; }","duration":"3.484571052s","start":"2026-06-16T00:32:23.726519Z","end":"2026-06-16T00:32:27.21109Z","steps":["trace[82269303] 'agreement among raft nodes before linearized reading' (duration: 3.484551692s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:27.211105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:23.726498Z","time spent":"3.484604103s","remote":"127.0.0.1:48812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-06-16T00:32:27.212305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:22.785009Z","time spent":"4.423566747s","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T00:32:27.214092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.043800793s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:32:27.214208Z","caller":"traceutil/trace.go:171","msg":"trace[981028911] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2830; }","duration":"2.050628399s","start":"2026-06-16T00:32:25.163567Z","end":"2026-06-16T00:32:27.214195Z","steps":["trace[981028911] 'range keys from in-memory index tree' (duration: 2.043786043s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:55.855281Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9834628818147493649,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-16T00:32:56.355646Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9834628818147493649,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-16T00:32:56.856569Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9834628818147493649,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-16T00:32:57.357695Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9834628818147493649,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-16T00:32:57.369329Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.06485922s","expected-duration":"1s"} {"level":"info","ts":"2026-06-16T00:32:57.369822Z","caller":"traceutil/trace.go:171","msg":"trace[1701843966] transaction","detail":"{read_only:false; response_revision:2983; number_of_response:1; }","duration":"2.065459418s","start":"2026-06-16T00:32:55.304328Z","end":"2026-06-16T00:32:57.369787Z","steps":["trace[1701843966] 'process raft request' (duration: 2.065280536s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:57.370012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:55.304301Z","time spent":"2.065603341s","remote":"127.0.0.1:45244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":762,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T00:32:57.370601Z","caller":"traceutil/trace.go:171","msg":"trace[63125990] transaction","detail":"{read_only:false; response_revision:2985; number_of_response:1; }","duration":"2.039844215s","start":"2026-06-16T00:32:55.330736Z","end":"2026-06-16T00:32:57.37058Z","steps":["trace[63125990] 'process raft request' (duration: 2.039543331s)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:32:57.37071Z","caller":"traceutil/trace.go:171","msg":"trace[1678625248] transaction","detail":"{read_only:false; response_revision:2984; number_of_response:1; }","duration":"2.043369767s","start":"2026-06-16T00:32:55.327224Z","end":"2026-06-16T00:32:57.370594Z","steps":["trace[1678625248] 'process raft request' (duration: 2.04287191s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:57.37079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:55.330727Z","time spent":"2.040000989s","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T00:32:57.370904Z","caller":"traceutil/trace.go:171","msg":"trace[2123827439] linearizableReadLoop","detail":"{readStateIndex:3100; appliedIndex:3096; }","duration":"2.016348902s","start":"2026-06-16T00:32:55.354516Z","end":"2026-06-16T00:32:57.370865Z","steps":["trace[2123827439] 'read index received' (duration: 2.015216976s)","trace[2123827439] 'applied index is now lower than readState.Index' (duration: 1.130556ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:32:57.370994Z","caller":"traceutil/trace.go:171","msg":"trace[643864473] transaction","detail":"{read_only:false; response_revision:2986; number_of_response:1; }","duration":"2.036882703s","start":"2026-06-16T00:32:55.334064Z","end":"2026-06-16T00:32:57.370947Z","steps":["trace[643864473] 'process raft request' (duration: 2.036467316s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:57.371052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:55.3272Z","time spent":"2.043682982s","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T00:32:57.371156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.016618196s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-16T00:32:57.371204Z","caller":"traceutil/trace.go:171","msg":"trace[1708785951] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2986; }","duration":"2.016714478s","start":"2026-06-16T00:32:55.354474Z","end":"2026-06-16T00:32:57.371189Z","steps":["trace[1708785951] 'agreement among raft nodes before linearized reading' (duration: 2.016549616s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:57.371218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:55.334039Z","time spent":"2.037052726s","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T00:32:57.371245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:55.354458Z","time spent":"2.016778799s","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-16T00:32:57.371426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.016360672s","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-06-16T00:32:57.371464Z","caller":"traceutil/trace.go:171","msg":"trace[411053002] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2986; }","duration":"2.016421244s","start":"2026-06-16T00:32:55.35503Z","end":"2026-06-16T00:32:57.371451Z","steps":["trace[411053002] 'agreement among raft nodes before linearized reading' (duration: 2.016340123s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:57.371499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:55.355018Z","time spent":"2.016471954s","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-06-16T00:32:57.371505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.380784713s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-06-16T00:32:57.371546Z","caller":"traceutil/trace.go:171","msg":"trace[792042457] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2986; }","duration":"1.380863205s","start":"2026-06-16T00:32:55.990673Z","end":"2026-06-16T00:32:57.371536Z","steps":["trace[792042457] 'agreement among raft nodes before linearized reading' (duration: 1.380694723s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:57.371586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:55.990654Z","time spent":"1.380923986s","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1392,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"warn","ts":"2026-06-16T00:32:57.371628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.009306999s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-16T00:32:57.371662Z","caller":"traceutil/trace.go:171","msg":"trace[282939031] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2986; }","duration":"2.009359711s","start":"2026-06-16T00:32:55.362293Z","end":"2026-06-16T00:32:57.371652Z","steps":["trace[282939031] 'agreement among raft nodes before linearized reading' (duration: 2.009274869s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:57.371693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:55.362281Z","time spent":"2.009406351s","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-16T00:32:57.371834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.014887031s","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-06-16T00:32:57.371867Z","caller":"traceutil/trace.go:171","msg":"trace[2038703951] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2986; }","duration":"2.014936051s","start":"2026-06-16T00:32:55.356923Z","end":"2026-06-16T00:32:57.371859Z","steps":["trace[2038703951] 'agreement among raft nodes before linearized reading' (duration: 2.01482833s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:57.371892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:55.356914Z","time spent":"2.014973092s","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-16T00:32:57.371969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.232632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-16T00:32:57.371997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.016334502s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-16T00:32:57.372014Z","caller":"traceutil/trace.go:171","msg":"trace[327153807] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:2986; }","duration":"605.317252ms","start":"2026-06-16T00:32:56.766684Z","end":"2026-06-16T00:32:57.372002Z","steps":["trace[327153807] 'agreement among raft nodes before linearized reading' (duration: 605.247562ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:57.372055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:56.766663Z","time spent":"605.382014ms","remote":"127.0.0.1:49618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":2,"response size":30,"request content":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true "} {"level":"warn","ts":"2026-06-16T00:32:57.372083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.016461995s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-16T00:32:57.372115Z","caller":"traceutil/trace.go:171","msg":"trace[936722044] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2986; }","duration":"2.016511805s","start":"2026-06-16T00:32:55.355596Z","end":"2026-06-16T00:32:57.372108Z","steps":["trace[936722044] 'agreement among raft nodes before linearized reading' (duration: 2.016441364s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:57.372147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:55.355586Z","time spent":"2.016554925s","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-16T00:32:57.372021Z","caller":"traceutil/trace.go:171","msg":"trace[1188675819] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2986; }","duration":"2.016356963s","start":"2026-06-16T00:32:55.355656Z","end":"2026-06-16T00:32:57.372013Z","steps":["trace[1188675819] 'agreement among raft nodes before linearized reading' (duration: 2.016289762s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:57.372258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:55.355625Z","time spent":"2.016620236s","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-16T00:32:57.372259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.144556934s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:32:57.37232Z","caller":"traceutil/trace.go:171","msg":"trace[1937906446] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2986; }","duration":"1.144662316s","start":"2026-06-16T00:32:56.227641Z","end":"2026-06-16T00:32:57.372303Z","steps":["trace[1937906446] 'agreement among raft nodes before linearized reading' (duration: 1.144546314s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:32:57.372372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:32:56.227619Z","time spent":"1.144740997s","remote":"127.0.0.1:45182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-16T00:35:44.227553Z","caller":"traceutil/trace.go:171","msg":"trace[2116356460] transaction","detail":"{read_only:false; response_revision:4634; number_of_response:1; }","duration":"161.010739ms","start":"2026-06-16T00:35:44.066518Z","end":"2026-06-16T00:35:44.227528Z","steps":["trace[2116356460] 'process raft request' (duration: 160.873698ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:35:44.232155Z","caller":"traceutil/trace.go:171","msg":"trace[1592855357] linearizableReadLoop","detail":"{readStateIndex:4812; appliedIndex:4810; }","duration":"128.058275ms","start":"2026-06-16T00:35:44.104085Z","end":"2026-06-16T00:35:44.232144Z","steps":["trace[1592855357] 'read index received' (duration: 123.262047ms)","trace[1592855357] 'applied index is now lower than readState.Index' (duration: 4.795578ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:35:44.232361Z","caller":"traceutil/trace.go:171","msg":"trace[184515331] transaction","detail":"{read_only:false; response_revision:4635; number_of_response:1; }","duration":"158.932642ms","start":"2026-06-16T00:35:44.073421Z","end":"2026-06-16T00:35:44.232354Z","steps":["trace[184515331] 'process raft request' (duration: 158.659409ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:35:44.232517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.416709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-06-16T00:35:44.232544Z","caller":"traceutil/trace.go:171","msg":"trace[1225208016] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4635; }","duration":"128.487719ms","start":"2026-06-16T00:35:44.104046Z","end":"2026-06-16T00:35:44.232534Z","steps":["trace[1225208016] 'agreement among raft nodes before linearized reading' (duration: 128.398908ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:35:57.409815Z","caller":"traceutil/trace.go:171","msg":"trace[854149503] linearizableReadLoop","detail":"{readStateIndex:5009; appliedIndex:5005; }","duration":"180.469181ms","start":"2026-06-16T00:35:57.229324Z","end":"2026-06-16T00:35:57.409793Z","steps":["trace[854149503] 'read index received' (duration: 9.171641ms)","trace[854149503] 'applied index is now lower than readState.Index' (duration: 171.29644ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:35:57.409907Z","caller":"traceutil/trace.go:171","msg":"trace[258341558] transaction","detail":"{read_only:false; response_revision:4825; number_of_response:1; }","duration":"181.161989ms","start":"2026-06-16T00:35:57.228706Z","end":"2026-06-16T00:35:57.409868Z","steps":["trace[258341558] 'process raft request' (duration: 181.003767ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:35:57.409952Z","caller":"traceutil/trace.go:171","msg":"trace[332686304] transaction","detail":"{read_only:false; response_revision:4826; number_of_response:1; }","duration":"181.182269ms","start":"2026-06-16T00:35:57.228716Z","end":"2026-06-16T00:35:57.409898Z","steps":["trace[332686304] 'process raft request' (duration: 181.041187ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:35:57.4098Z","caller":"traceutil/trace.go:171","msg":"trace[1574329242] transaction","detail":"{read_only:false; response_revision:4824; number_of_response:1; }","duration":"181.095139ms","start":"2026-06-16T00:35:57.228673Z","end":"2026-06-16T00:35:57.409768Z","steps":["trace[1574329242] 'process raft request' (duration: 90.893934ms)","trace[1574329242] 'compare' (duration: 89.997552ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:35:57.41024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.688773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-16T00:35:57.410285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.996042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-16T00:35:57.410375Z","caller":"traceutil/trace.go:171","msg":"trace[347652105] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4826; }","duration":"151.129415ms","start":"2026-06-16T00:35:57.259228Z","end":"2026-06-16T00:35:57.410357Z","steps":["trace[347652105] 'agreement among raft nodes before linearized reading' (duration: 150.916302ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:35:57.410283Z","caller":"traceutil/trace.go:171","msg":"trace[743844700] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4826; }","duration":"181.008748ms","start":"2026-06-16T00:35:57.229263Z","end":"2026-06-16T00:35:57.410272Z","steps":["trace[743844700] 'agreement among raft nodes before linearized reading' (duration: 180.711134ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:37:31.182546Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2855} {"level":"info","ts":"2026-06-16T00:37:31.265793Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2855,"took":"81.933172ms","hash":916811574,"current-db-size-bytes":52887552,"current-db-size":"53 MB","current-db-size-in-use-bytes":29552640,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-16T00:37:31.265854Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":916811574,"revision":2855,"compact-revision":-1} {"level":"warn","ts":"2026-06-16T00:39:21.870562Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9834628818147501811,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-16T00:39:22.371445Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9834628818147501811,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-16T00:39:22.87185Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9834628818147501811,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-16T00:39:23.111642Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.772302288s","expected-duration":"1s"} {"level":"info","ts":"2026-06-16T00:39:23.112058Z","caller":"traceutil/trace.go:171","msg":"trace[769434465] transaction","detail":"{read_only:false; response_revision:6323; number_of_response:1; }","duration":"1.772820955s","start":"2026-06-16T00:39:21.339215Z","end":"2026-06-16T00:39:23.112036Z","steps":["trace[769434465] 'process raft request' (duration: 1.772687221s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:39:23.112267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:39:21.339188Z","time spent":"1.772938969s","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T00:39:23.146155Z","caller":"traceutil/trace.go:171","msg":"trace[1203307537] transaction","detail":"{read_only:false; response_revision:6324; number_of_response:1; }","duration":"1.806013972s","start":"2026-06-16T00:39:21.340118Z","end":"2026-06-16T00:39:23.146132Z","steps":["trace[1203307537] 'process raft request' (duration: 1.805839667s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:39:23.146331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:39:21.340105Z","time spent":"1.806118226s","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T00:39:23.146477Z","caller":"traceutil/trace.go:171","msg":"trace[249269985] transaction","detail":"{read_only:false; response_revision:6325; number_of_response:1; }","duration":"579.23317ms","start":"2026-06-16T00:39:22.567218Z","end":"2026-06-16T00:39:23.146451Z","steps":["trace[249269985] 'process raft request' (duration: 578.870309ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:39:23.146552Z","caller":"traceutil/trace.go:171","msg":"trace[546626270] linearizableReadLoop","detail":"{readStateIndex:6560; appliedIndex:6555; }","duration":"1.776087372s","start":"2026-06-16T00:39:21.370448Z","end":"2026-06-16T00:39:23.146535Z","steps":["trace[546626270] 'read index received' (duration: 1.741434409s)","trace[546626270] 'applied index is now lower than readState.Index' (duration: 34.651723ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:39:23.146634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:39:22.567191Z","time spent":"579.366714ms","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T00:39:23.146665Z","caller":"traceutil/trace.go:171","msg":"trace[1514558657] transaction","detail":"{read_only:false; response_revision:6326; number_of_response:1; }","duration":"414.927022ms","start":"2026-06-16T00:39:22.731724Z","end":"2026-06-16T00:39:23.146651Z","steps":["trace[1514558657] 'process raft request' (duration: 414.581172ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:39:23.146708Z","caller":"traceutil/trace.go:171","msg":"trace[2112160416] transaction","detail":"{read_only:false; response_revision:6327; number_of_response:1; }","duration":"386.299664ms","start":"2026-06-16T00:39:22.760395Z","end":"2026-06-16T00:39:23.146694Z","steps":["trace[2112160416] 'process raft request' (duration: 386.029526ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:39:23.146741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:39:22.731699Z","time spent":"414.999055ms","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T00:39:23.146781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:39:22.760376Z","time spent":"386.359136ms","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T00:39:23.146931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.776494155s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-16T00:39:23.146967Z","caller":"traceutil/trace.go:171","msg":"trace[2057856851] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6328; }","duration":"1.776570427s","start":"2026-06-16T00:39:21.370386Z","end":"2026-06-16T00:39:23.146957Z","steps":["trace[2057856851] 'agreement among raft nodes before linearized reading' (duration: 1.776446333s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:39:23.146998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:39:21.370364Z","time spent":"1.776625959s","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-16T00:39:23.147052Z","caller":"traceutil/trace.go:171","msg":"trace[683735311] transaction","detail":"{read_only:false; response_revision:6328; number_of_response:1; }","duration":"274.408223ms","start":"2026-06-16T00:39:22.872628Z","end":"2026-06-16T00:39:23.147036Z","steps":["trace[683735311] 'process raft request' (duration: 273.865746ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:39:23.147113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"692.120662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-16T00:39:23.14714Z","caller":"traceutil/trace.go:171","msg":"trace[612710500] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:6328; }","duration":"692.175564ms","start":"2026-06-16T00:39:22.454957Z","end":"2026-06-16T00:39:23.147132Z","steps":["trace[612710500] 'agreement among raft nodes before linearized reading' (duration: 692.104892ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:39:23.147179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:39:22.454941Z","time spent":"692.230705ms","remote":"127.0.0.1:45404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":40,"response size":30,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-06-16T00:39:23.147283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.249421478s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1990"} {"level":"info","ts":"2026-06-16T00:39:23.147341Z","caller":"traceutil/trace.go:171","msg":"trace[1852509279] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:6328; }","duration":"1.249516441s","start":"2026-06-16T00:39:21.897809Z","end":"2026-06-16T00:39:23.147325Z","steps":["trace[1852509279] 'agreement among raft nodes before linearized reading' (duration: 1.249376337s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:39:23.147364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.863792ms","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":"warn","ts":"2026-06-16T00:39:23.147383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:39:21.89779Z","time spent":"1.249584493s","remote":"127.0.0.1:45338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2013,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"info","ts":"2026-06-16T00:39:23.147396Z","caller":"traceutil/trace.go:171","msg":"trace[906955905] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:6328; }","duration":"533.939964ms","start":"2026-06-16T00:39:22.613446Z","end":"2026-06-16T00:39:23.147386Z","steps":["trace[906955905] 'agreement among raft nodes before linearized reading' (duration: 533.883442ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:39:23.147431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:39:22.613416Z","time spent":"534.001836ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-16T00:39:23.147314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.72843928s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-06-16T00:39:23.14756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"919.164685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-16T00:39:23.147592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.20457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-16T00:39:23.147596Z","caller":"traceutil/trace.go:171","msg":"trace[1204535090] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6328; }","duration":"919.199046ms","start":"2026-06-16T00:39:22.228388Z","end":"2026-06-16T00:39:23.147587Z","steps":["trace[1204535090] 'agreement among raft nodes before linearized reading' (duration: 919.146094ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:39:23.147619Z","caller":"traceutil/trace.go:171","msg":"trace[1673074830] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:6328; }","duration":"658.274132ms","start":"2026-06-16T00:39:22.489337Z","end":"2026-06-16T00:39:23.147612Z","steps":["trace[1673074830] 'agreement among raft nodes before linearized reading' (duration: 658.22503ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:39:23.147636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:39:22.228328Z","time spent":"919.301909ms","remote":"127.0.0.1:45182","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-06-16T00:39:23.147646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:39:22.489319Z","time spent":"658.320173ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":4,"response size":30,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-06-16T00:39:23.147932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.72811411s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-16T00:39:23.147984Z","caller":"traceutil/trace.go:171","msg":"trace[292640001] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6328; }","duration":"1.728169312s","start":"2026-06-16T00:39:21.419803Z","end":"2026-06-16T00:39:23.147972Z","steps":["trace[292640001] 'agreement among raft nodes before linearized reading' (duration: 1.728013787s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:39:23.148005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.729030988s","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-06-16T00:39:23.148062Z","caller":"traceutil/trace.go:171","msg":"trace[1085384013] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6328; }","duration":"1.729106761s","start":"2026-06-16T00:39:21.418945Z","end":"2026-06-16T00:39:23.148051Z","steps":["trace[1085384013] 'agreement among raft nodes before linearized reading' (duration: 1.728974277s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:39:23.148016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:39:21.419737Z","time spent":"1.728271855s","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-16T00:39:23.148097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:39:21.418934Z","time spent":"1.729155782s","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-16T00:39:23.148618Z","caller":"traceutil/trace.go:171","msg":"trace[1512324367] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6328; }","duration":"1.728804201s","start":"2026-06-16T00:39:21.418732Z","end":"2026-06-16T00:39:23.147536Z","steps":["trace[1512324367] 'agreement among raft nodes before linearized reading' (duration: 1.728145811s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:39:23.148685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:39:21.418709Z","time spent":"1.729958618s","remote":"127.0.0.1:45392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-16T00:42:31.187837Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5573} {"level":"info","ts":"2026-06-16T00:42:31.276128Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5573,"took":"86.557255ms","hash":4241952411,"current-db-size-bytes":52887552,"current-db-size":"53 MB","current-db-size-in-use-bytes":18321408,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-16T00:42:31.276184Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4241952411,"revision":5573,"compact-revision":2855}