{"level":"warn","ts":"2026-08-04T15:22:07.854178Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-04T15:22:07.854327Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.86: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.86:2380","--initial-cluster=instance=https://199.19.213.86:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.86:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.86: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-08-04T15:22:07.854452Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-04T15:22:07.854478Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.86:2380"]} {"level":"info","ts":"2026-08-04T15:22:07.854511Z","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-08-04T15:22:07.856903Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.86:2379"]} {"level":"info","ts":"2026-08-04T15:22:07.857226Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.86:2380"],"listen-peer-urls":["https://199.19.213.86:2380"],"advertise-client-urls":["https://199.19.213.86:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.86:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.86: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-08-04T15:22:07.860912Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.342923ms"} {"level":"info","ts":"2026-08-04T15:22:07.871657Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"849a6ffb5e81c109","cluster-id":"d4d86b1dd8829199"} {"level":"info","ts":"2026-08-04T15:22:07.871786Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"849a6ffb5e81c109 switched to configuration voters=()"} {"level":"info","ts":"2026-08-04T15:22:07.871832Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"849a6ffb5e81c109 became follower at term 0"} {"level":"info","ts":"2026-08-04T15:22:07.871854Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 849a6ffb5e81c109 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-04T15:22:07.87187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"849a6ffb5e81c109 became follower at term 1"} {"level":"info","ts":"2026-08-04T15:22:07.871928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"849a6ffb5e81c109 switched to configuration voters=(9555072684832964873)"} {"level":"warn","ts":"2026-08-04T15:22:07.877354Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-04T15:22:07.881219Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-04T15:22:07.88259Z","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-08-04T15:22:07.884836Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"849a6ffb5e81c109","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-04T15:22:07.885062Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"849a6ffb5e81c109","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-04T15:22:07.885163Z","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-08-04T15:22:07.885246Z","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-08-04T15:22:07.885256Z","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-08-04T15:22:07.886124Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"849a6ffb5e81c109 switched to configuration voters=(9555072684832964873)"} {"level":"info","ts":"2026-08-04T15:22:07.886282Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d4d86b1dd8829199","local-member-id":"849a6ffb5e81c109","added-peer-id":"849a6ffb5e81c109","added-peer-peer-urls":["https://199.19.213.86:2380"]} {"level":"info","ts":"2026-08-04T15:22:07.888298Z","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-08-04T15:22:07.88841Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.86:2380"} {"level":"info","ts":"2026-08-04T15:22:07.888436Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.86:2380"} {"level":"info","ts":"2026-08-04T15:22:07.888656Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"849a6ffb5e81c109","initial-advertise-peer-urls":["https://199.19.213.86:2380"],"listen-peer-urls":["https://199.19.213.86:2380"],"advertise-client-urls":["https://199.19.213.86:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.86:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-04T15:22:07.88874Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-04T15:22:08.172542Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"849a6ffb5e81c109 is starting a new election at term 1"} {"level":"info","ts":"2026-08-04T15:22:08.172654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"849a6ffb5e81c109 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-04T15:22:08.172682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"849a6ffb5e81c109 received MsgPreVoteResp from 849a6ffb5e81c109 at term 1"} {"level":"info","ts":"2026-08-04T15:22:08.172704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"849a6ffb5e81c109 became candidate at term 2"} {"level":"info","ts":"2026-08-04T15:22:08.172711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"849a6ffb5e81c109 received MsgVoteResp from 849a6ffb5e81c109 at term 2"} {"level":"info","ts":"2026-08-04T15:22:08.172724Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"849a6ffb5e81c109 became leader at term 2"} {"level":"info","ts":"2026-08-04T15:22:08.172735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 849a6ffb5e81c109 elected leader 849a6ffb5e81c109 at term 2"} {"level":"info","ts":"2026-08-04T15:22:08.176164Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"849a6ffb5e81c109","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.86:2379]}","request-path":"/0/members/849a6ffb5e81c109/attributes","cluster-id":"d4d86b1dd8829199","publish-timeout":"7s"} {"level":"info","ts":"2026-08-04T15:22:08.176167Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-04T15:22:08.176152Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T15:22:08.176259Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-04T15:22:08.176507Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-04T15:22:08.176602Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-04T15:22:08.177236Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d4d86b1dd8829199","local-member-id":"849a6ffb5e81c109","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T15:22:08.177494Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T15:22:08.177599Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T15:22:08.180214Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.86:2379"} {"level":"info","ts":"2026-08-04T15:22:08.18045Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-08-04T15:22:51.892402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.003413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-66kmd\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-08-04T15:22:51.892548Z","caller":"traceutil/trace.go:171","msg":"trace[73175771] range","detail":"{range_begin:/registry/pods/kube-system/cilium-66kmd; range_end:; response_count:1; response_revision:632; }","duration":"112.226418ms","start":"2026-08-04T15:22:51.780295Z","end":"2026-08-04T15:22:51.892522Z","steps":["trace[73175771] 'range keys from in-memory index tree' (duration: 111.779027ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:22:51.930079Z","caller":"traceutil/trace.go:171","msg":"trace[1089502445] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"135.056201ms","start":"2026-08-04T15:22:51.794996Z","end":"2026-08-04T15:22:51.930052Z","steps":["trace[1089502445] 'process raft request' (duration: 134.353044ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:22:52.256589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.0591ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:22:52.256738Z","caller":"traceutil/trace.go:171","msg":"trace[247291190] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:654; }","duration":"338.973342ms","start":"2026-08-04T15:22:51.917739Z","end":"2026-08-04T15:22:52.256713Z","steps":["trace[247291190] 'read index received' (duration: 11.34762ms)","trace[247291190] 'applied index is now lower than readState.Index' (duration: 327.623742ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:22:52.256761Z","caller":"traceutil/trace.go:171","msg":"trace[702779300] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"344.517499ms","start":"2026-08-04T15:22:51.9122Z","end":"2026-08-04T15:22:52.256718Z","steps":["trace[702779300] 'process raft request' (duration: 127.426554ms)","trace[702779300] 'compare' (duration: 215.882915ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:22:52.256959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:22:51.91216Z","time spent":"344.700333ms","remote":"127.0.0.1:43356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:22:52.257043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.273719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-04T15:22:52.257159Z","caller":"traceutil/trace.go:171","msg":"trace[144307025] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:634; }","duration":"339.450213ms","start":"2026-08-04T15:22:51.91768Z","end":"2026-08-04T15:22:52.25713Z","steps":["trace[144307025] 'agreement among raft nodes before linearized reading' (duration: 339.123615ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:22:52.257213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:22:51.917657Z","time spent":"339.546976ms","remote":"127.0.0.1:43456","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-08-04T15:22:52.318959Z","caller":"traceutil/trace.go:171","msg":"trace[281432672] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"328.353569ms","start":"2026-08-04T15:22:51.990584Z","end":"2026-08-04T15:22:52.318938Z","steps":["trace[281432672] 'process raft request' (duration: 328.231037ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:22:52.319123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:22:51.990553Z","time spent":"328.490893ms","remote":"127.0.0.1:43548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-04T15:22:52.319381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.112449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-04T15:22:52.319526Z","caller":"traceutil/trace.go:171","msg":"trace[1435002653] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:635; }","duration":"164.324064ms","start":"2026-08-04T15:22:52.155172Z","end":"2026-08-04T15:22:52.319496Z","steps":["trace[1435002653] 'agreement among raft nodes before linearized reading' (duration: 163.791771ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:24:25.042449Z","caller":"traceutil/trace.go:171","msg":"trace[633730000] linearizableReadLoop","detail":"{readStateIndex:1941; appliedIndex:1940; }","duration":"157.262948ms","start":"2026-08-04T15:24:24.885163Z","end":"2026-08-04T15:24:25.042426Z","steps":["trace[633730000] 'read index received' (duration: 157.091084ms)","trace[633730000] 'applied index is now lower than readState.Index' (duration: 170.834µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:24:25.042712Z","caller":"traceutil/trace.go:171","msg":"trace[1949482397] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"195.291475ms","start":"2026-08-04T15:24:24.847409Z","end":"2026-08-04T15:24:25.042701Z","steps":["trace[1949482397] 'process raft request' (duration: 194.886036ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:24:25.188358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.004093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-04T15:24:25.188453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.209279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:24:25.188488Z","caller":"traceutil/trace.go:171","msg":"trace[1545891347] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1868; }","duration":"168.236918ms","start":"2026-08-04T15:24:25.020218Z","end":"2026-08-04T15:24:25.188455Z","steps":["trace[1545891347] 'agreement among raft nodes before linearized reading' (duration: 22.671839ms)","trace[1545891347] 'count revisions from in-memory index tree' (duration: 145.333854ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:24:25.188545Z","caller":"traceutil/trace.go:171","msg":"trace[581800766] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1868; }","duration":"102.368003ms","start":"2026-08-04T15:24:25.086157Z","end":"2026-08-04T15:24:25.188525Z","steps":["trace[581800766] 'range keys from in-memory index tree' (duration: 102.079216ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:24:25.188517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.245687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-04T15:24:25.188747Z","caller":"traceutil/trace.go:171","msg":"trace[2073584022] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1868; }","duration":"303.396701ms","start":"2026-08-04T15:24:24.885203Z","end":"2026-08-04T15:24:25.1886Z","steps":["trace[2073584022] 'agreement among raft nodes before linearized reading' (duration: 157.656707ms)","trace[2073584022] 'range keys from in-memory index tree' (duration: 145.444726ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:24:25.188807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:24:24.885197Z","time spent":"303.599716ms","remote":"127.0.0.1:43456","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-08-04T15:24:25.188762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.576255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-04T15:24:25.188908Z","caller":"traceutil/trace.go:171","msg":"trace[1984972873] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1868; }","duration":"303.75985ms","start":"2026-08-04T15:24:24.885126Z","end":"2026-08-04T15:24:25.188886Z","steps":["trace[1984972873] 'agreement among raft nodes before linearized reading' (duration: 157.75677ms)","trace[1984972873] 'range keys from in-memory index tree' (duration: 145.739114ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:24:25.188961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:24:24.885104Z","time spent":"303.847131ms","remote":"127.0.0.1:43456","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-08-04T15:24:25.681433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.777544ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:24:25.681549Z","caller":"traceutil/trace.go:171","msg":"trace[2120079107] linearizableReadLoop","detail":"{readStateIndex:1945; appliedIndex:1944; }","duration":"271.790172ms","start":"2026-08-04T15:24:25.409744Z","end":"2026-08-04T15:24:25.681534Z","steps":["trace[2120079107] 'read index received' (duration: 125.798322ms)","trace[2120079107] 'applied index is now lower than readState.Index' (duration: 145.99081ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:24:25.681627Z","caller":"traceutil/trace.go:171","msg":"trace[1636521631] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"302.5439ms","start":"2026-08-04T15:24:25.379029Z","end":"2026-08-04T15:24:25.681573Z","steps":["trace[1636521631] 'process raft request' (duration: 156.54236ms)","trace[1636521631] 'compare' (duration: 145.666172ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:24:25.681829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.078459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-08621696-838f-414e-81c4-736156d07a23\" ","response":"range_response_count:1 size:3746"} {"level":"warn","ts":"2026-08-04T15:24:25.681824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.52175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:24:25.681887Z","caller":"traceutil/trace.go:171","msg":"trace[937556855] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-08621696-838f-414e-81c4-736156d07a23; range_end:; response_count:1; response_revision:1872; }","duration":"272.174561ms","start":"2026-08-04T15:24:25.409696Z","end":"2026-08-04T15:24:25.681871Z","steps":["trace[937556855] 'agreement among raft nodes before linearized reading' (duration: 271.905385ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:24:25.681889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:24:25.379003Z","time spent":"302.756246ms","remote":"127.0.0.1:43456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:24:25.681928Z","caller":"traceutil/trace.go:171","msg":"trace[804646314] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1872; }","duration":"137.721736ms","start":"2026-08-04T15:24:25.544179Z","end":"2026-08-04T15:24:25.681901Z","steps":["trace[804646314] 'agreement among raft nodes before linearized reading' (duration: 137.529991ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:25:10.396188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.1646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-08-04T15:25:10.396249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.414181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:25:10.396321Z","caller":"traceutil/trace.go:171","msg":"trace[1103705107] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2161; }","duration":"115.364954ms","start":"2026-08-04T15:25:10.28093Z","end":"2026-08-04T15:25:10.396295Z","steps":["trace[1103705107] 'range keys from in-memory index tree' (duration: 114.916884ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:25:10.39641Z","caller":"traceutil/trace.go:171","msg":"trace[1048180912] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2161; }","duration":"309.625085ms","start":"2026-08-04T15:25:10.086707Z","end":"2026-08-04T15:25:10.396332Z","steps":["trace[1048180912] 'range keys from in-memory index tree' (duration: 309.292087ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:25:10.396495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:25:10.086679Z","time spent":"309.80442ms","remote":"127.0.0.1:43154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-04T15:25:10.517709Z","caller":"traceutil/trace.go:171","msg":"trace[2033815240] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"116.642806ms","start":"2026-08-04T15:25:10.401032Z","end":"2026-08-04T15:25:10.517675Z","steps":["trace[2033815240] 'process raft request' (duration: 116.40902ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:26:04.381994Z","caller":"traceutil/trace.go:171","msg":"trace[329774888] transaction","detail":"{read_only:false; response_revision:2627; number_of_response:1; }","duration":"142.185731ms","start":"2026-08-04T15:26:04.239781Z","end":"2026-08-04T15:26:04.381966Z","steps":["trace[329774888] 'process raft request' (duration: 141.995017ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:26:37.575893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.105893ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-08-04T15:26:37.576065Z","caller":"traceutil/trace.go:171","msg":"trace[17433844] linearizableReadLoop","detail":"{readStateIndex:2935; appliedIndex:2934; }","duration":"227.603776ms","start":"2026-08-04T15:26:37.348397Z","end":"2026-08-04T15:26:37.576001Z","steps":["trace[17433844] 'read index received' (duration: 98.296698ms)","trace[17433844] 'applied index is now lower than readState.Index' (duration: 129.305508ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:26:37.576534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.136858ms","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-08-04T15:26:37.576573Z","caller":"traceutil/trace.go:171","msg":"trace[1968321002] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2826; }","duration":"228.2239ms","start":"2026-08-04T15:26:37.348339Z","end":"2026-08-04T15:26:37.576563Z","steps":["trace[1968321002] 'agreement among raft nodes before linearized reading' (duration: 227.761019ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:26:38.044725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.629558ms","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-08-04T15:26:38.044809Z","caller":"traceutil/trace.go:171","msg":"trace[1487086684] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2827; }","duration":"245.789691ms","start":"2026-08-04T15:26:37.799Z","end":"2026-08-04T15:26:38.04479Z","steps":["trace[1487086684] 'range keys from in-memory index tree' (duration: 245.434542ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:26:38.176239Z","caller":"traceutil/trace.go:171","msg":"trace[261940654] transaction","detail":"{read_only:false; response_revision:2828; number_of_response:1; }","duration":"127.112803ms","start":"2026-08-04T15:26:38.049094Z","end":"2026-08-04T15:26:38.176207Z","steps":["trace[261940654] 'process raft request' (duration: 126.840717ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:26:38.203509Z","caller":"traceutil/trace.go:171","msg":"trace[1715505068] linearizableReadLoop","detail":"{readStateIndex:2939; appliedIndex:2936; }","duration":"125.889714ms","start":"2026-08-04T15:26:38.077571Z","end":"2026-08-04T15:26:38.203461Z","steps":["trace[1715505068] 'read index received' (duration: 98.445762ms)","trace[1715505068] 'applied index is now lower than readState.Index' (duration: 27.442522ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:26:38.203637Z","caller":"traceutil/trace.go:171","msg":"trace[229877128] transaction","detail":"{read_only:false; response_revision:2829; number_of_response:1; }","duration":"154.474344ms","start":"2026-08-04T15:26:38.049146Z","end":"2026-08-04T15:26:38.20362Z","steps":["trace[229877128] 'process raft request' (duration: 154.030624ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:26:38.203709Z","caller":"traceutil/trace.go:171","msg":"trace[1435589418] transaction","detail":"{read_only:false; response_revision:2830; number_of_response:1; }","duration":"154.361782ms","start":"2026-08-04T15:26:38.049311Z","end":"2026-08-04T15:26:38.203672Z","steps":["trace[1435589418] 'process raft request' (duration: 154.075505ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:26:38.203791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.459197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:26:38.203868Z","caller":"traceutil/trace.go:171","msg":"trace[314145539] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2830; }","duration":"117.612811ms","start":"2026-08-04T15:26:38.086234Z","end":"2026-08-04T15:26:38.203847Z","steps":["trace[314145539] 'agreement among raft nodes before linearized reading' (duration: 117.462507ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:26:38.20388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.308344ms","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-08-04T15:26:38.203942Z","caller":"traceutil/trace.go:171","msg":"trace[43684565] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2830; }","duration":"126.413187ms","start":"2026-08-04T15:26:38.077513Z","end":"2026-08-04T15:26:38.203926Z","steps":["trace[43684565] 'agreement among raft nodes before linearized reading' (duration: 126.180881ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:29:19.237324Z","caller":"traceutil/trace.go:171","msg":"trace[1019708737] transaction","detail":"{read_only:false; response_revision:3879; number_of_response:1; }","duration":"148.608348ms","start":"2026-08-04T15:29:19.088679Z","end":"2026-08-04T15:29:19.237287Z","steps":["trace[1019708737] 'process raft request' (duration: 109.787527ms)","trace[1019708737] 'compare' (duration: 38.513913ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:29:19.237377Z","caller":"traceutil/trace.go:171","msg":"trace[1618046803] transaction","detail":"{read_only:false; response_revision:3880; number_of_response:1; }","duration":"146.891665ms","start":"2026-08-04T15:29:19.090458Z","end":"2026-08-04T15:29:19.23735Z","steps":["trace[1618046803] 'process raft request' (duration: 146.753392ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:29:19.237336Z","caller":"traceutil/trace.go:171","msg":"trace[1280513658] linearizableReadLoop","detail":"{readStateIndex:4027; appliedIndex:4025; }","duration":"145.052611ms","start":"2026-08-04T15:29:19.092258Z","end":"2026-08-04T15:29:19.23731Z","steps":["trace[1280513658] 'read index received' (duration: 106.229301ms)","trace[1280513658] 'applied index is now lower than readState.Index' (duration: 38.82214ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:29:19.237511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.228365ms","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-08-04T15:29:19.237554Z","caller":"traceutil/trace.go:171","msg":"trace[686247630] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:3880; }","duration":"145.302787ms","start":"2026-08-04T15:29:19.09224Z","end":"2026-08-04T15:29:19.237543Z","steps":["trace[686247630] 'agreement among raft nodes before linearized reading' (duration: 145.146873ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:29:19.237637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.929995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-255ft\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-08-04T15:29:19.237673Z","caller":"traceutil/trace.go:171","msg":"trace[1387242801] range","detail":"{range_begin:/registry/pods/openstack/keepalived-255ft; range_end:; response_count:1; response_revision:3880; }","duration":"142.000047ms","start":"2026-08-04T15:29:19.095663Z","end":"2026-08-04T15:29:19.237663Z","steps":["trace[1387242801] 'agreement among raft nodes before linearized reading' (duration: 141.847583ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:30:44.565626Z","caller":"traceutil/trace.go:171","msg":"trace[641107398] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4864; }","duration":"102.201552ms","start":"2026-08-04T15:30:44.463384Z","end":"2026-08-04T15:30:44.565586Z","steps":["trace[641107398] 'process raft request' (duration: 48.895002ms)","trace[641107398] 'compare' (duration: 53.141466ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:30:51.96666Z","caller":"traceutil/trace.go:171","msg":"trace[1714220641] transaction","detail":"{read_only:false; response_revision:5088; number_of_response:1; }","duration":"166.695594ms","start":"2026-08-04T15:30:51.799929Z","end":"2026-08-04T15:30:51.966624Z","steps":["trace[1714220641] 'process raft request' (duration: 157.9124ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:30:51.966663Z","caller":"traceutil/trace.go:171","msg":"trace[2092523387] linearizableReadLoop","detail":"{readStateIndex:5283; appliedIndex:5282; }","duration":"164.730456ms","start":"2026-08-04T15:30:51.801892Z","end":"2026-08-04T15:30:51.966622Z","steps":["trace[2092523387] 'read index received' (duration: 155.967052ms)","trace[2092523387] 'applied index is now lower than readState.Index' (duration: 8.761334ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:30:51.966898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.970871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/vector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:30:51.966947Z","caller":"traceutil/trace.go:171","msg":"trace[25843615] range","detail":"{range_begin:/registry/configmaps/monitoring/vector; range_end:; response_count:0; response_revision:5088; }","duration":"165.080354ms","start":"2026-08-04T15:30:51.801854Z","end":"2026-08-04T15:30:51.966934Z","steps":["trace[25843615] 'agreement among raft nodes before linearized reading' (duration: 164.940611ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:30:51.988431Z","caller":"traceutil/trace.go:171","msg":"trace[1445604515] transaction","detail":"{read_only:false; response_revision:5089; number_of_response:1; }","duration":"185.040432ms","start":"2026-08-04T15:30:51.803366Z","end":"2026-08-04T15:30:51.988406Z","steps":["trace[1445604515] 'process raft request' (duration: 184.864018ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:30:51.989685Z","caller":"traceutil/trace.go:171","msg":"trace[71779965] transaction","detail":"{read_only:false; response_revision:5091; number_of_response:1; }","duration":"185.716049ms","start":"2026-08-04T15:30:51.80395Z","end":"2026-08-04T15:30:51.989666Z","steps":["trace[71779965] 'process raft request' (duration: 185.321989ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:30:51.989831Z","caller":"traceutil/trace.go:171","msg":"trace[1892024838] transaction","detail":"{read_only:false; response_revision:5090; number_of_response:1; }","duration":"186.298593ms","start":"2026-08-04T15:30:51.803481Z","end":"2026-08-04T15:30:51.989779Z","steps":["trace[1892024838] 'process raft request' (duration: 184.887908ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:30:51.989918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.6449ms","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-08-04T15:30:51.989938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.063963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a96fea64-5868-4f86-8f55-517592894528\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-08-04T15:30:51.989986Z","caller":"traceutil/trace.go:171","msg":"trace[1428473010] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a96fea64-5868-4f86-8f55-517592894528; range_end:; response_count:1; response_revision:5092; }","duration":"169.245847ms","start":"2026-08-04T15:30:51.820729Z","end":"2026-08-04T15:30:51.989975Z","steps":["trace[1428473010] 'agreement among raft nodes before linearized reading' (duration: 169.093773ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:30:51.989992Z","caller":"traceutil/trace.go:171","msg":"trace[1864994306] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5092; }","duration":"106.766634ms","start":"2026-08-04T15:30:51.883204Z","end":"2026-08-04T15:30:51.98997Z","steps":["trace[1864994306] 'agreement among raft nodes before linearized reading' (duration: 106.513158ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:30:51.989914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.119647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:16178"} {"level":"info","ts":"2026-08-04T15:30:51.990185Z","caller":"traceutil/trace.go:171","msg":"trace[917370785] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5092; }","duration":"115.455455ms","start":"2026-08-04T15:30:51.874705Z","end":"2026-08-04T15:30:51.990161Z","steps":["trace[917370785] 'agreement among raft nodes before linearized reading' (duration: 114.979594ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:30:51.990275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.465011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:7 size:62859"} {"level":"info","ts":"2026-08-04T15:30:51.99032Z","caller":"traceutil/trace.go:171","msg":"trace[1789277749] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:7; response_revision:5092; }","duration":"187.509492ms","start":"2026-08-04T15:30:51.802797Z","end":"2026-08-04T15:30:51.990306Z","steps":["trace[1789277749] 'agreement among raft nodes before linearized reading' (duration: 187.302007ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:30:53.71755Z","caller":"traceutil/trace.go:171","msg":"trace[768410713] linearizableReadLoop","detail":"{readStateIndex:5316; appliedIndex:5315; }","duration":"132.49892ms","start":"2026-08-04T15:30:53.585035Z","end":"2026-08-04T15:30:53.717534Z","steps":["trace[768410713] 'read index received' (duration: 132.310756ms)","trace[768410713] 'applied index is now lower than readState.Index' (duration: 187.474µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:30:53.717678Z","caller":"traceutil/trace.go:171","msg":"trace[1768159974] transaction","detail":"{read_only:false; response_revision:5119; number_of_response:1; }","duration":"134.51753ms","start":"2026-08-04T15:30:53.583121Z","end":"2026-08-04T15:30:53.717639Z","steps":["trace[1768159974] 'process raft request' (duration: 134.279644ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:30:53.717722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.633164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-04T15:30:53.717811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.846469ms","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-08-04T15:30:53.717885Z","caller":"traceutil/trace.go:171","msg":"trace[1307204478] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:5119; }","duration":"132.9113ms","start":"2026-08-04T15:30:53.584952Z","end":"2026-08-04T15:30:53.717863Z","steps":["trace[1307204478] 'agreement among raft nodes before linearized reading' (duration: 132.668934ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:30:53.717935Z","caller":"traceutil/trace.go:171","msg":"trace[863385081] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:5119; }","duration":"110.034743ms","start":"2026-08-04T15:30:53.607873Z","end":"2026-08-04T15:30:53.717907Z","steps":["trace[863385081] 'agreement among raft nodes before linearized reading' (duration: 109.827688ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:31:04.926254Z","caller":"traceutil/trace.go:171","msg":"trace[164906123] transaction","detail":"{read_only:false; response_revision:5357; number_of_response:1; }","duration":"117.33163ms","start":"2026-08-04T15:31:04.808903Z","end":"2026-08-04T15:31:04.926234Z","steps":["trace[164906123] 'process raft request' (duration: 25.855751ms)","trace[164906123] 'compare' (duration: 91.217313ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:31:04.926238Z","caller":"traceutil/trace.go:171","msg":"trace[1006457806] transaction","detail":"{read_only:false; response_revision:5358; number_of_response:1; }","duration":"116.321276ms","start":"2026-08-04T15:31:04.809887Z","end":"2026-08-04T15:31:04.926209Z","steps":["trace[1006457806] 'process raft request' (duration: 116.265494ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:31:05.327826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.768651ms","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-08-04T15:31:05.327927Z","caller":"traceutil/trace.go:171","msg":"trace[85227451] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5358; }","duration":"117.937986ms","start":"2026-08-04T15:31:05.20997Z","end":"2026-08-04T15:31:05.327908Z","steps":["trace[85227451] 'range keys from in-memory index tree' (duration: 117.571177ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:31:05.328146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.683943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:31:05.328258Z","caller":"traceutil/trace.go:171","msg":"trace[839543549] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5358; }","duration":"241.855587ms","start":"2026-08-04T15:31:05.086378Z","end":"2026-08-04T15:31:05.328233Z","steps":["trace[839543549] 'range keys from in-memory index tree' (duration: 241.472787ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:32:08.640582Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2997} {"level":"info","ts":"2026-08-04T15:32:08.715396Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2997,"took":"72.718135ms","hash":1197451968,"current-db-size-bytes":57847808,"current-db-size":"58 MB","current-db-size-in-use-bytes":33689600,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-04T15:32:08.715471Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1197451968,"revision":2997,"compact-revision":-1} {"level":"warn","ts":"2026-08-04T15:32:20.657972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.753728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:32:20.658092Z","caller":"traceutil/trace.go:171","msg":"trace[1912599930] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:6129; }","duration":"127.936353ms","start":"2026-08-04T15:32:20.530131Z","end":"2026-08-04T15:32:20.658067Z","steps":["trace[1912599930] 'range keys from in-memory index tree' (duration: 127.633286ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:32:20.65811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.312906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-08-04T15:32:20.658198Z","caller":"traceutil/trace.go:171","msg":"trace[1052796309] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:6129; }","duration":"104.432789ms","start":"2026-08-04T15:32:20.553733Z","end":"2026-08-04T15:32:20.658165Z","steps":["trace[1052796309] 'range keys from in-memory index tree' (duration: 104.159063ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:32:20.658527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.437575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:32:20.658554Z","caller":"traceutil/trace.go:171","msg":"trace[1752832057] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:6129; }","duration":"128.499616ms","start":"2026-08-04T15:32:20.530048Z","end":"2026-08-04T15:32:20.658547Z","steps":["trace[1752832057] 'range keys from in-memory index tree' (duration: 128.356152ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:32:20.658595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.771208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-08-04T15:32:20.658822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.426665ms","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-08-04T15:32:20.65889Z","caller":"traceutil/trace.go:171","msg":"trace[106835094] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6129; }","duration":"146.500357ms","start":"2026-08-04T15:32:20.512374Z","end":"2026-08-04T15:32:20.658875Z","steps":["trace[106835094] 'range keys from in-memory index tree' (duration: 146.140748ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:32:20.658669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.98091ms","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-08-04T15:32:20.658693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.428645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-255ft\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-08-04T15:32:20.659096Z","caller":"traceutil/trace.go:171","msg":"trace[689833420] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6129; }","duration":"159.402501ms","start":"2026-08-04T15:32:20.499641Z","end":"2026-08-04T15:32:20.659044Z","steps":["trace[689833420] 'range keys from in-memory index tree' (duration: 158.656653ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:32:20.658883Z","caller":"traceutil/trace.go:171","msg":"trace[233770329] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6129; }","duration":"146.087418ms","start":"2026-08-04T15:32:20.512767Z","end":"2026-08-04T15:32:20.658855Z","steps":["trace[233770329] 'range keys from in-memory index tree' (duration: 145.588214ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:32:20.659175Z","caller":"traceutil/trace.go:171","msg":"trace[873256751] range","detail":"{range_begin:/registry/pods/openstack/keepalived-255ft; range_end:; response_count:1; response_revision:6129; }","duration":"137.99071ms","start":"2026-08-04T15:32:20.521162Z","end":"2026-08-04T15:32:20.659153Z","steps":["trace[873256751] 'range keys from in-memory index tree' (duration: 137.187759ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:32:20.766866Z","caller":"traceutil/trace.go:171","msg":"trace[1242686112] transaction","detail":"{read_only:false; response_revision:6131; number_of_response:1; }","duration":"102.156894ms","start":"2026-08-04T15:32:20.664684Z","end":"2026-08-04T15:32:20.766841Z","steps":["trace[1242686112] 'process raft request' (duration: 102.01438ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:32:20.767251Z","caller":"traceutil/trace.go:171","msg":"trace[498959774] transaction","detail":"{read_only:false; response_revision:6132; number_of_response:1; }","duration":"102.495462ms","start":"2026-08-04T15:32:20.664744Z","end":"2026-08-04T15:32:20.76724Z","steps":["trace[498959774] 'process raft request' (duration: 102.054302ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:32:20.767652Z","caller":"traceutil/trace.go:171","msg":"trace[1627663428] transaction","detail":"{read_only:false; response_revision:6133; number_of_response:1; }","duration":"102.792409ms","start":"2026-08-04T15:32:20.66483Z","end":"2026-08-04T15:32:20.767622Z","steps":["trace[1627663428] 'process raft request' (duration: 102.361309ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:37:08.650165Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6047} {"level":"info","ts":"2026-08-04T15:37:08.742936Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6047,"took":"89.951274ms","hash":913200245,"current-db-size-bytes":57847808,"current-db-size":"58 MB","current-db-size-in-use-bytes":22958080,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-08-04T15:37:08.743024Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":913200245,"revision":6047,"compact-revision":2997} {"level":"info","ts":"2026-08-04T15:37:24.593877Z","caller":"traceutil/trace.go:171","msg":"trace[316052058] linearizableReadLoop","detail":"{readStateIndex:8663; appliedIndex:8662; }","duration":"167.302689ms","start":"2026-08-04T15:37:24.426547Z","end":"2026-08-04T15:37:24.59385Z","steps":["trace[316052058] 'read index received' (duration: 166.852838ms)","trace[316052058] 'applied index is now lower than readState.Index' (duration: 447.561µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:37:24.593986Z","caller":"traceutil/trace.go:171","msg":"trace[135112685] transaction","detail":"{read_only:false; response_revision:8366; number_of_response:1; }","duration":"167.449423ms","start":"2026-08-04T15:37:24.426479Z","end":"2026-08-04T15:37:24.593929Z","steps":["trace[135112685] 'process raft request' (duration: 166.952151ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:37:24.594126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.620647ms","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-08-04T15:37:24.594184Z","caller":"traceutil/trace.go:171","msg":"trace[835959584] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8366; }","duration":"167.72115ms","start":"2026-08-04T15:37:24.42645Z","end":"2026-08-04T15:37:24.594171Z","steps":["trace[835959584] 'agreement among raft nodes before linearized reading' (duration: 167.551665ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:37:24.59435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.853784ms","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-08-04T15:37:24.594397Z","caller":"traceutil/trace.go:171","msg":"trace[984668296] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8366; }","duration":"167.938775ms","start":"2026-08-04T15:37:24.426448Z","end":"2026-08-04T15:37:24.594387Z","steps":["trace[984668296] 'agreement among raft nodes before linearized reading' (duration: 167.766141ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:37:24.631035Z","caller":"traceutil/trace.go:171","msg":"trace[1510780374] transaction","detail":"{read_only:false; response_revision:8367; number_of_response:1; }","duration":"200.996927ms","start":"2026-08-04T15:37:24.429999Z","end":"2026-08-04T15:37:24.630996Z","steps":["trace[1510780374] 'process raft request' (duration: 200.771282ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:37:24.631176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.986961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5683"} {"level":"info","ts":"2026-08-04T15:37:24.631275Z","caller":"traceutil/trace.go:171","msg":"trace[1909482493] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:8367; }","duration":"204.123193ms","start":"2026-08-04T15:37:24.427124Z","end":"2026-08-04T15:37:24.631247Z","steps":["trace[1909482493] 'agreement among raft nodes before linearized reading' (duration: 203.813216ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:37:24.631724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.790839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-08-04T15:37:24.631769Z","caller":"traceutil/trace.go:171","msg":"trace[1703951992] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8367; }","duration":"103.894462ms","start":"2026-08-04T15:37:24.527863Z","end":"2026-08-04T15:37:24.631757Z","steps":["trace[1703951992] 'agreement among raft nodes before linearized reading' (duration: 103.712207ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:37:26.736206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.057158ms","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-08-04T15:37:26.736305Z","caller":"traceutil/trace.go:171","msg":"trace[1580868730] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8376; }","duration":"100.173591ms","start":"2026-08-04T15:37:26.636106Z","end":"2026-08-04T15:37:26.73628Z","steps":["trace[1580868730] 'agreement among raft nodes before linearized reading' (duration: 99.887574ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:37:26.736008Z","caller":"traceutil/trace.go:171","msg":"trace[68532209] transaction","detail":"{read_only:false; response_revision:8376; number_of_response:1; }","duration":"132.419673ms","start":"2026-08-04T15:37:26.603551Z","end":"2026-08-04T15:37:26.73597Z","steps":["trace[68532209] 'process raft request' (duration: 132.093965ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:37:55.245443Z","caller":"traceutil/trace.go:171","msg":"trace[949534372] linearizableReadLoop","detail":"{readStateIndex:8888; appliedIndex:8887; }","duration":"345.617736ms","start":"2026-08-04T15:37:54.899796Z","end":"2026-08-04T15:37:55.245414Z","steps":["trace[949534372] 'read index received' (duration: 345.567865ms)","trace[949534372] 'applied index is now lower than readState.Index' (duration: 48.781µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:37:55.24559Z","caller":"traceutil/trace.go:171","msg":"trace[281999398] transaction","detail":"{read_only:false; response_revision:8582; number_of_response:1; }","duration":"357.005343ms","start":"2026-08-04T15:37:54.888532Z","end":"2026-08-04T15:37:55.245537Z","steps":["trace[281999398] 'process raft request' (duration: 356.732086ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:37:55.245685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.878623ms","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-08-04T15:37:55.245719Z","caller":"traceutil/trace.go:171","msg":"trace[1693919442] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8582; }","duration":"345.985005ms","start":"2026-08-04T15:37:54.899726Z","end":"2026-08-04T15:37:55.245711Z","steps":["trace[1693919442] 'agreement among raft nodes before linearized reading' (duration: 345.838832ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:37:55.245751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:37:54.899696Z","time spent":"346.048647ms","remote":"127.0.0.1:43456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-04T15:37:55.245838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:37:54.888499Z","time spent":"357.193947ms","remote":"127.0.0.1:43456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:37:55.246747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.337015ms","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-08-04T15:37:55.246824Z","caller":"traceutil/trace.go:171","msg":"trace[741045527] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8583; }","duration":"344.446808ms","start":"2026-08-04T15:37:54.902358Z","end":"2026-08-04T15:37:55.246805Z","steps":["trace[741045527] 'agreement among raft nodes before linearized reading' (duration: 344.253613ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:37:55.24682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.541739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-04T15:37:55.246864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:37:54.902343Z","time spent":"344.512519ms","remote":"127.0.0.1:43456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-04T15:37:55.246902Z","caller":"traceutil/trace.go:171","msg":"trace[83924751] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8583; }","duration":"161.664583ms","start":"2026-08-04T15:37:55.085219Z","end":"2026-08-04T15:37:55.246883Z","steps":["trace[83924751] 'agreement among raft nodes before linearized reading' (duration: 161.538159ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:37:55.24709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.333949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-255ft\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-08-04T15:37:55.24713Z","caller":"traceutil/trace.go:171","msg":"trace[1141426312] range","detail":"{range_begin:/registry/pods/openstack/keepalived-255ft; range_end:; response_count:1; response_revision:8583; }","duration":"333.39153ms","start":"2026-08-04T15:37:54.913729Z","end":"2026-08-04T15:37:55.247121Z","steps":["trace[1141426312] 'agreement among raft nodes before linearized reading' (duration: 333.290937ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:37:55.247135Z","caller":"traceutil/trace.go:171","msg":"trace[647540512] transaction","detail":"{read_only:false; response_revision:8583; number_of_response:1; }","duration":"165.071536ms","start":"2026-08-04T15:37:55.082053Z","end":"2026-08-04T15:37:55.247125Z","steps":["trace[647540512] 'process raft request' (duration: 164.44409ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:37:55.247163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:37:54.913719Z","time spent":"333.434361ms","remote":"127.0.0.1:43356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6544,"request content":"key:\"/registry/pods/openstack/keepalived-255ft\" "} {"level":"warn","ts":"2026-08-04T15:37:55.247381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.917298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-08-04T15:37:55.247423Z","caller":"traceutil/trace.go:171","msg":"trace[1285403389] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8583; }","duration":"334.970809ms","start":"2026-08-04T15:37:54.912437Z","end":"2026-08-04T15:37:55.247408Z","steps":["trace[1285403389] 'agreement among raft nodes before linearized reading' (duration: 334.879237ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:37:55.247458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:37:54.912428Z","time spent":"335.02182ms","remote":"127.0.0.1:43456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-08-04T15:37:55.247696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.655927ms","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-08-04T15:37:55.247733Z","caller":"traceutil/trace.go:171","msg":"trace[1983226975] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8583; }","duration":"338.712609ms","start":"2026-08-04T15:37:54.909012Z","end":"2026-08-04T15:37:55.247724Z","steps":["trace[1983226975] 'agreement among raft nodes before linearized reading' (duration: 338.566466ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:37:55.247763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:37:54.909003Z","time spent":"338.7512ms","remote":"127.0.0.1:43456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-04T15:38:08.182495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.462118ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-04T15:38:08.182643Z","caller":"traceutil/trace.go:171","msg":"trace[805607180] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8697; }","duration":"245.549727ms","start":"2026-08-04T15:38:07.937072Z","end":"2026-08-04T15:38:08.182622Z","steps":["trace[805607180] 'process raft request' (duration: 116.777253ms)","trace[805607180] 'compare' (duration: 128.122189ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:38:08.18551Z","caller":"traceutil/trace.go:171","msg":"trace[23682902] transaction","detail":"{read_only:false; response_revision:8698; number_of_response:1; }","duration":"242.635267ms","start":"2026-08-04T15:38:07.942846Z","end":"2026-08-04T15:38:08.185482Z","steps":["trace[23682902] 'process raft request' (duration: 242.393751ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:38:09.613381Z","caller":"traceutil/trace.go:171","msg":"trace[1197082299] transaction","detail":"{read_only:false; response_revision:8708; number_of_response:1; }","duration":"120.444303ms","start":"2026-08-04T15:38:09.492908Z","end":"2026-08-04T15:38:09.613352Z","steps":["trace[1197082299] 'process raft request' (duration: 120.224448ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:38:23.122693Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023c1.wal"} {"level":"info","ts":"2026-08-04T15:39:22.229544Z","caller":"traceutil/trace.go:171","msg":"trace[688735825] transaction","detail":"{read_only:false; response_revision:9431; number_of_response:1; }","duration":"101.427685ms","start":"2026-08-04T15:39:22.128084Z","end":"2026-08-04T15:39:22.229512Z","steps":["trace[688735825] 'process raft request' (duration: 101.23624ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:39:54.608631Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"849a6ffb5e81c109","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-04T15:39:54.61496Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-04T15:39:54.615091Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-08-04T15:40:10.225935Z","caller":"traceutil/trace.go:171","msg":"trace[1175074433] transaction","detail":"{read_only:false; response_revision:9770; number_of_response:1; }","duration":"160.732297ms","start":"2026-08-04T15:40:10.065173Z","end":"2026-08-04T15:40:10.225906Z","steps":["trace[1175074433] 'process raft request' (duration: 160.565033ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:40:10.243196Z","caller":"traceutil/trace.go:171","msg":"trace[2037376703] linearizableReadLoop","detail":"{readStateIndex:10113; appliedIndex:10111; }","duration":"176.973661ms","start":"2026-08-04T15:40:10.066202Z","end":"2026-08-04T15:40:10.243176Z","steps":["trace[2037376703] 'read index received' (duration: 159.528077ms)","trace[2037376703] 'applied index is now lower than readState.Index' (duration: 17.444464ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:40:10.243458Z","caller":"traceutil/trace.go:171","msg":"trace[861888035] transaction","detail":"{read_only:false; response_revision:9771; number_of_response:1; }","duration":"177.590466ms","start":"2026-08-04T15:40:10.065786Z","end":"2026-08-04T15:40:10.243376Z","steps":["trace[861888035] 'process raft request' (duration: 177.297809ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:40:10.243736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.974525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-04T15:40:10.243737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.501823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-08-04T15:40:10.243785Z","caller":"traceutil/trace.go:171","msg":"trace[798298599] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9771; }","duration":"157.088858ms","start":"2026-08-04T15:40:10.086683Z","end":"2026-08-04T15:40:10.243772Z","steps":["trace[798298599] 'agreement among raft nodes before linearized reading' (duration: 156.976275ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:40:10.243909Z","caller":"traceutil/trace.go:171","msg":"trace[2089879505] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:9771; }","duration":"177.635287ms","start":"2026-08-04T15:40:10.066186Z","end":"2026-08-04T15:40:10.243821Z","steps":["trace[2089879505] 'agreement among raft nodes before linearized reading' (duration: 177.251808ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:40:10.243945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.526035ms","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":"warn","ts":"2026-08-04T15:40:10.243935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.781703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:130379"} {"level":"info","ts":"2026-08-04T15:40:10.24406Z","caller":"traceutil/trace.go:171","msg":"trace[652827616] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:9771; }","duration":"170.607346ms","start":"2026-08-04T15:40:10.073389Z","end":"2026-08-04T15:40:10.243996Z","steps":["trace[652827616] 'agreement among raft nodes before linearized reading' (duration: 170.36733ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:40:10.244071Z","caller":"traceutil/trace.go:171","msg":"trace[1691463704] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:9771; }","duration":"173.960727ms","start":"2026-08-04T15:40:10.070083Z","end":"2026-08-04T15:40:10.244043Z","steps":["trace[1691463704] 'agreement among raft nodes before linearized reading' (duration: 173.520667ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:42:08.655535Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8236} {"level":"info","ts":"2026-08-04T15:42:08.730978Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8236,"took":"73.033452ms","hash":1586473694,"current-db-size-bytes":57847808,"current-db-size":"58 MB","current-db-size-in-use-bytes":25546752,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-08-04T15:42:08.731066Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1586473694,"revision":8236,"compact-revision":6047}