{"level":"warn","ts":"2026-10-17T10:48:07.316739Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-17T10:48:07.316871Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.191: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://162.253.55.191:2380","--initial-cluster=instance=https://162.253.55.191:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.191:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.191: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-10-17T10:48:07.316967Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-17T10:48:07.316978Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.191:2380"]} {"level":"info","ts":"2026-10-17T10:48:07.317004Z","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-10-17T10:48:07.317888Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.191:2379"]} {"level":"info","ts":"2026-10-17T10:48:07.318054Z","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://162.253.55.191:2380"],"listen-peer-urls":["https://162.253.55.191:2380"],"advertise-client-urls":["https://162.253.55.191:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.191:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.191: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-10-17T10:48:07.324232Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.530576ms"} {"level":"info","ts":"2026-10-17T10:48:07.330595Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"adb6690514c92321","cluster-id":"ee04900e3a861beb"} {"level":"info","ts":"2026-10-17T10:48:07.330696Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 switched to configuration voters=()"} {"level":"info","ts":"2026-10-17T10:48:07.330782Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 became follower at term 0"} {"level":"info","ts":"2026-10-17T10:48:07.330803Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft adb6690514c92321 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-17T10:48:07.330919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 became follower at term 1"} {"level":"info","ts":"2026-10-17T10:48:07.331088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 switched to configuration voters=(12517307684867351329)"} {"level":"warn","ts":"2026-10-17T10:48:07.34109Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-17T10:48:07.342653Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-17T10:48:07.343894Z","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-10-17T10:48:07.346085Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"adb6690514c92321","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-17T10:48:07.346214Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"adb6690514c92321","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-17T10:48:07.346382Z","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-10-17T10:48:07.346598Z","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-10-17T10:48:07.348076Z","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-10-17T10:48:07.349131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 switched to configuration voters=(12517307684867351329)"} {"level":"info","ts":"2026-10-17T10:48:07.349332Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ee04900e3a861beb","local-member-id":"adb6690514c92321","added-peer-id":"adb6690514c92321","added-peer-peer-urls":["https://162.253.55.191:2380"]} {"level":"info","ts":"2026-10-17T10:48:07.351538Z","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-10-17T10:48:07.351579Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.191:2380"} {"level":"info","ts":"2026-10-17T10:48:07.351693Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.191:2380"} {"level":"info","ts":"2026-10-17T10:48:07.35253Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-17T10:48:07.352488Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"adb6690514c92321","initial-advertise-peer-urls":["https://162.253.55.191:2380"],"listen-peer-urls":["https://162.253.55.191:2380"],"advertise-client-urls":["https://162.253.55.191:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.191:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-17T10:48:07.632078Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 is starting a new election at term 1"} {"level":"info","ts":"2026-10-17T10:48:07.632239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-17T10:48:07.632341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 received MsgPreVoteResp from adb6690514c92321 at term 1"} {"level":"info","ts":"2026-10-17T10:48:07.63239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 became candidate at term 2"} {"level":"info","ts":"2026-10-17T10:48:07.632422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 received MsgVoteResp from adb6690514c92321 at term 2"} {"level":"info","ts":"2026-10-17T10:48:07.63246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 became leader at term 2"} {"level":"info","ts":"2026-10-17T10:48:07.632535Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: adb6690514c92321 elected leader adb6690514c92321 at term 2"} {"level":"info","ts":"2026-10-17T10:48:07.633491Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"adb6690514c92321","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.191:2379]}","request-path":"/0/members/adb6690514c92321/attributes","cluster-id":"ee04900e3a861beb","publish-timeout":"7s"} {"level":"info","ts":"2026-10-17T10:48:07.633523Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:48:07.633684Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T10:48:07.634041Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-17T10:48:07.63416Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-17T10:48:07.633725Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T10:48:07.634803Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ee04900e3a861beb","local-member-id":"adb6690514c92321","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:48:07.635003Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:48:07.635158Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:48:07.639432Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.191:2379"} {"level":"info","ts":"2026-10-17T10:48:07.639445Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-17T10:48:57.824204Z","caller":"traceutil/trace.go:171","msg":"trace[1921834914] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:673; }","duration":"286.754106ms","start":"2026-10-17T10:48:57.537422Z","end":"2026-10-17T10:48:57.824176Z","steps":["trace[1921834914] 'read index received' (duration: 261.000688ms)","trace[1921834914] 'applied index is now lower than readState.Index' (duration: 25.751998ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:48:57.824254Z","caller":"traceutil/trace.go:171","msg":"trace[516872726] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"298.857213ms","start":"2026-10-17T10:48:57.52536Z","end":"2026-10-17T10:48:57.824218Z","steps":["trace[516872726] 'process raft request' (duration: 273.090213ms)","trace[516872726] 'compare' (duration: 25.611199ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:48:57.824501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.053107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-10-17T10:48:57.824536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.338061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-10-17T10:48:57.824617Z","caller":"traceutil/trace.go:171","msg":"trace[1984695556] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:649; }","duration":"145.469069ms","start":"2026-10-17T10:48:57.679129Z","end":"2026-10-17T10:48:57.824598Z","steps":["trace[1984695556] 'agreement among raft nodes before linearized reading' (duration: 145.216572ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:48:57.824677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.37284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-17T10:48:57.824578Z","caller":"traceutil/trace.go:171","msg":"trace[434377449] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:649; }","duration":"287.186255ms","start":"2026-10-17T10:48:57.537377Z","end":"2026-10-17T10:48:57.824564Z","steps":["trace[434377449] 'agreement among raft nodes before linearized reading' (duration: 286.950799ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:48:57.824702Z","caller":"traceutil/trace.go:171","msg":"trace[1970856895] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:649; }","duration":"130.431034ms","start":"2026-10-17T10:48:57.694263Z","end":"2026-10-17T10:48:57.824694Z","steps":["trace[1970856895] 'agreement among raft nodes before linearized reading' (duration: 130.355609ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:48:58.425507Z","caller":"traceutil/trace.go:171","msg":"trace[538128042] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"488.165639ms","start":"2026-10-17T10:48:57.937311Z","end":"2026-10-17T10:48:58.425477Z","steps":["trace[538128042] 'process raft request' (duration: 487.997007ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:48:58.426367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:48:57.937287Z","time spent":"488.293567ms","remote":"127.0.0.1:51658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:48:58.484004Z","caller":"traceutil/trace.go:171","msg":"trace[671948899] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"178.573542ms","start":"2026-10-17T10:48:58.305409Z","end":"2026-10-17T10:48:58.483983Z","steps":["trace[671948899] 'process raft request' (duration: 177.843383ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:49:13.230167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.862138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:49:13.230266Z","caller":"traceutil/trace.go:171","msg":"trace[1919456432] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:808; }","duration":"330.02178ms","start":"2026-10-17T10:49:12.900223Z","end":"2026-10-17T10:49:13.230245Z","steps":["trace[1919456432] 'range keys from in-memory index tree' (duration: 329.7533ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:49:13.230327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:49:12.900202Z","time spent":"330.115626ms","remote":"127.0.0.1:51454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-17T10:49:13.230458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.44204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-6wtx8\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-10-17T10:49:13.230605Z","caller":"traceutil/trace.go:171","msg":"trace[23507931] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-6wtx8; range_end:; response_count:1; response_revision:808; }","duration":"210.670886ms","start":"2026-10-17T10:49:13.019909Z","end":"2026-10-17T10:49:13.23058Z","steps":["trace[23507931] 'range keys from in-memory index tree' (duration: 210.14914ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:50:10.484694Z","caller":"traceutil/trace.go:171","msg":"trace[1247132968] linearizableReadLoop","detail":"{readStateIndex:1539; appliedIndex:1538; }","duration":"132.684426ms","start":"2026-10-17T10:50:10.351983Z","end":"2026-10-17T10:50:10.484667Z","steps":["trace[1247132968] 'read index received' (duration: 132.528084ms)","trace[1247132968] 'applied index is now lower than readState.Index' (duration: 154.462µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:50:10.484774Z","caller":"traceutil/trace.go:171","msg":"trace[1999887678] transaction","detail":"{read_only:false; response_revision:1492; number_of_response:1; }","duration":"147.90645ms","start":"2026-10-17T10:50:10.336837Z","end":"2026-10-17T10:50:10.484744Z","steps":["trace[1999887678] 'process raft request' (duration: 147.625469ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:50:10.484963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.965228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-10-17T10:50:10.485022Z","caller":"traceutil/trace.go:171","msg":"trace[2052840901] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1492; }","duration":"133.073555ms","start":"2026-10-17T10:50:10.351933Z","end":"2026-10-17T10:50:10.485006Z","steps":["trace[2052840901] 'agreement among raft nodes before linearized reading' (duration: 132.854639ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:50:37.107675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.61949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:50:37.107762Z","caller":"traceutil/trace.go:171","msg":"trace[846870902] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1900; }","duration":"207.782622ms","start":"2026-10-17T10:50:36.899961Z","end":"2026-10-17T10:50:37.107744Z","steps":["trace[846870902] 'range keys from in-memory index tree' (duration: 207.528604ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:50:37.618996Z","caller":"traceutil/trace.go:171","msg":"trace[1239380912] linearizableReadLoop","detail":"{readStateIndex:1979; appliedIndex:1978; }","duration":"198.974661ms","start":"2026-10-17T10:50:37.419991Z","end":"2026-10-17T10:50:37.618966Z","steps":["trace[1239380912] 'read index received' (duration: 190.255363ms)","trace[1239380912] 'applied index is now lower than readState.Index' (duration: 8.717888ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:50:37.619205Z","caller":"traceutil/trace.go:171","msg":"trace[591188871] transaction","detail":"{read_only:false; response_revision:1903; number_of_response:1; }","duration":"260.675242ms","start":"2026-10-17T10:50:37.358369Z","end":"2026-10-17T10:50:37.619045Z","steps":["trace[591188871] 'process raft request' (duration: 252.017018ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:50:37.619457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.443717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-140f3468-f4ff-49d6-963a-4e0d6b7b0eac\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-17T10:50:37.61953Z","caller":"traceutil/trace.go:171","msg":"trace[1329110400] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-140f3468-f4ff-49d6-963a-4e0d6b7b0eac; range_end:; response_count:1; response_revision:1903; }","duration":"199.564856ms","start":"2026-10-17T10:50:37.419949Z","end":"2026-10-17T10:50:37.619513Z","steps":["trace[1329110400] 'agreement among raft nodes before linearized reading' (duration: 199.131573ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:51:12.274046Z","caller":"traceutil/trace.go:171","msg":"trace[1408225727] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"108.834111ms","start":"2026-10-17T10:51:12.165193Z","end":"2026-10-17T10:51:12.274027Z","steps":["trace[1408225727] 'process raft request' (duration: 108.459421ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:51:12.772513Z","caller":"traceutil/trace.go:171","msg":"trace[229171630] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"107.07197ms","start":"2026-10-17T10:51:12.665418Z","end":"2026-10-17T10:51:12.77249Z","steps":["trace[229171630] 'process raft request' (duration: 106.985282ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:51:12.772609Z","caller":"traceutil/trace.go:171","msg":"trace[1201612835] linearizableReadLoop","detail":"{readStateIndex:2233; appliedIndex:2232; }","duration":"178.876674ms","start":"2026-10-17T10:51:12.593719Z","end":"2026-10-17T10:51:12.772596Z","steps":["trace[1201612835] 'read index received' (duration: 150.848969ms)","trace[1201612835] 'applied index is now lower than readState.Index' (duration: 28.026335ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:51:12.772534Z","caller":"traceutil/trace.go:171","msg":"trace[450960732] transaction","detail":"{read_only:false; response_revision:2149; number_of_response:1; }","duration":"201.77563ms","start":"2026-10-17T10:51:12.570735Z","end":"2026-10-17T10:51:12.772511Z","steps":["trace[450960732] 'process raft request' (duration: 173.827563ms)","trace[450960732] 'compare' (duration: 27.580598ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:51:12.773049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.816053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-17T10:51:12.773149Z","caller":"traceutil/trace.go:171","msg":"trace[1631821457] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2150; }","duration":"177.980899ms","start":"2026-10-17T10:51:12.595151Z","end":"2026-10-17T10:51:12.773132Z","steps":["trace[1631821457] 'agreement among raft nodes before linearized reading' (duration: 177.730156ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:51:12.773321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.130417ms","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-10-17T10:51:12.773435Z","caller":"traceutil/trace.go:171","msg":"trace[1743311149] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2150; }","duration":"179.73189ms","start":"2026-10-17T10:51:12.593688Z","end":"2026-10-17T10:51:12.77342Z","steps":["trace[1743311149] 'agreement among raft nodes before linearized reading' (duration: 179.0262ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:51:12.77434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.666363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-10-17T10:51:12.774438Z","caller":"traceutil/trace.go:171","msg":"trace[904670781] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2150; }","duration":"158.813969ms","start":"2026-10-17T10:51:12.615602Z","end":"2026-10-17T10:51:12.774416Z","steps":["trace[904670781] 'agreement among raft nodes before linearized reading' (duration: 157.379588ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:51:13.104018Z","caller":"traceutil/trace.go:171","msg":"trace[1748478069] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"326.196764ms","start":"2026-10-17T10:51:12.777797Z","end":"2026-10-17T10:51:13.103994Z","steps":["trace[1748478069] 'process raft request' (duration: 326.055537ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:51:13.104268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:51:12.777775Z","time spent":"326.386258ms","remote":"127.0.0.1:51756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:51:13.22573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.3639ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T10:51:13.22593Z","caller":"traceutil/trace.go:171","msg":"trace[472466100] linearizableReadLoop","detail":"{readStateIndex:2238; appliedIndex:2235; }","duration":"424.150792ms","start":"2026-10-17T10:51:12.801765Z","end":"2026-10-17T10:51:13.225916Z","steps":["trace[472466100] 'read index received' (duration: 302.302984ms)","trace[472466100] 'applied index is now lower than readState.Index' (duration: 121.844668ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:51:13.225996Z","caller":"traceutil/trace.go:171","msg":"trace[373136272] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"447.978344ms","start":"2026-10-17T10:51:12.778012Z","end":"2026-10-17T10:51:13.22599Z","steps":["trace[373136272] 'process raft request' (duration: 346.133617ms)","trace[373136272] 'compare' (duration: 101.146746ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:51:13.226033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:51:12.777989Z","time spent":"448.025623ms","remote":"127.0.0.1:51756","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-10-17T10:51:13.226049Z","caller":"traceutil/trace.go:171","msg":"trace[852988245] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"447.104959ms","start":"2026-10-17T10:51:12.778913Z","end":"2026-10-17T10:51:13.226018Z","steps":["trace[852988245] 'process raft request' (duration: 446.972192ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:51:13.226114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.106191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-17T10:51:13.226138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.544841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:51:13.226169Z","caller":"traceutil/trace.go:171","msg":"trace[730845922] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2154; }","duration":"325.208008ms","start":"2026-10-17T10:51:12.900947Z","end":"2026-10-17T10:51:13.226155Z","steps":["trace[730845922] 'agreement among raft nodes before linearized reading' (duration: 325.070282ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:51:13.226194Z","caller":"traceutil/trace.go:171","msg":"trace[142928298] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:2154; }","duration":"279.609039ms","start":"2026-10-17T10:51:12.946567Z","end":"2026-10-17T10:51:13.226176Z","steps":["trace[142928298] 'agreement among raft nodes before linearized reading' (duration: 279.460893ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:51:13.22626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:51:12.7789Z","time spent":"447.258574ms","remote":"127.0.0.1:51756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:51:13.22627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.874095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5732"} {"level":"warn","ts":"2026-10-17T10:51:13.226343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.855031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-17T10:51:13.226355Z","caller":"traceutil/trace.go:171","msg":"trace[2146425844] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2154; }","duration":"276.993361ms","start":"2026-10-17T10:51:12.949335Z","end":"2026-10-17T10:51:13.226328Z","steps":["trace[2146425844] 'agreement among raft nodes before linearized reading' (duration: 276.691159ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:51:13.226369Z","caller":"traceutil/trace.go:171","msg":"trace[830038927] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2154; }","duration":"304.916149ms","start":"2026-10-17T10:51:12.921445Z","end":"2026-10-17T10:51:13.226361Z","steps":["trace[830038927] 'agreement among raft nodes before linearized reading' (duration: 304.802072ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:51:13.226359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.588181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-17T10:51:13.226396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:51:12.921428Z","time spent":"304.962778ms","remote":"127.0.0.1:51756","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":"info","ts":"2026-10-17T10:51:13.226441Z","caller":"traceutil/trace.go:171","msg":"trace[1583701851] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:2154; }","duration":"424.704797ms","start":"2026-10-17T10:51:12.801724Z","end":"2026-10-17T10:51:13.226429Z","steps":["trace[1583701851] 'agreement among raft nodes before linearized reading' (duration: 424.588401ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:51:13.226474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:51:12.80171Z","time spent":"424.752887ms","remote":"127.0.0.1:57580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-10-17T10:51:13.226202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:51:12.900929Z","time spent":"325.264967ms","remote":"127.0.0.1:51454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-17T10:51:13.226606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.025572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-17T10:51:13.226642Z","caller":"traceutil/trace.go:171","msg":"trace[557589103] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:2154; }","duration":"154.10513ms","start":"2026-10-17T10:51:13.072528Z","end":"2026-10-17T10:51:13.226633Z","steps":["trace[557589103] 'agreement among raft nodes before linearized reading' (duration: 154.035082ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:51:13.226485Z","caller":"traceutil/trace.go:171","msg":"trace[1058469138] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"447.694112ms","start":"2026-10-17T10:51:12.778774Z","end":"2026-10-17T10:51:13.226468Z","steps":["trace[1058469138] 'process raft request' (duration: 447.0445ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:51:13.226845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:51:12.778754Z","time spent":"448.038073ms","remote":"127.0.0.1:51756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:52:19.941723Z","caller":"traceutil/trace.go:171","msg":"trace[1334564907] transaction","detail":"{read_only:false; response_revision:2610; number_of_response:1; }","duration":"283.799781ms","start":"2026-10-17T10:52:19.657897Z","end":"2026-10-17T10:52:19.941697Z","steps":["trace[1334564907] 'process raft request' (duration: 283.637869ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:52:19.942422Z","caller":"traceutil/trace.go:171","msg":"trace[2044276396] transaction","detail":"{read_only:false; response_revision:2611; number_of_response:1; }","duration":"234.604641ms","start":"2026-10-17T10:52:19.707787Z","end":"2026-10-17T10:52:19.942392Z","steps":["trace[2044276396] 'process raft request' (duration: 234.43012ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:52:56.340155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.33815ms","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-10-17T10:52:56.340298Z","caller":"traceutil/trace.go:171","msg":"trace[940973504] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2810; }","duration":"193.527143ms","start":"2026-10-17T10:52:56.146741Z","end":"2026-10-17T10:52:56.340268Z","steps":["trace[940973504] 'range keys from in-memory index tree' (duration: 193.110434ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:52:56.597584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.278074ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"warn","ts":"2026-10-17T10:52:56.597704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.345875ms","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-10-17T10:52:56.597843Z","caller":"traceutil/trace.go:171","msg":"trace[1302785603] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2810; }","duration":"112.490709ms","start":"2026-10-17T10:52:56.48533Z","end":"2026-10-17T10:52:56.597821Z","steps":["trace[1302785603] 'range keys from in-memory index tree' (duration: 112.326854ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:52:56.598214Z","caller":"traceutil/trace.go:171","msg":"trace[1663498042] linearizableReadLoop","detail":"{readStateIndex:2918; appliedIndex:2916; }","duration":"222.183141ms","start":"2026-10-17T10:52:56.376011Z","end":"2026-10-17T10:52:56.598194Z","steps":["trace[1663498042] 'read index received' (duration: 82.214943ms)","trace[1663498042] 'applied index is now lower than readState.Index' (duration: 139.966448ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:52:56.598366Z","caller":"traceutil/trace.go:171","msg":"trace[575134921] transaction","detail":"{read_only:false; response_revision:2811; number_of_response:1; }","duration":"253.520321ms","start":"2026-10-17T10:52:56.344828Z","end":"2026-10-17T10:52:56.598349Z","steps":["trace[575134921] 'process raft request' (duration: 252.974808ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:52:56.605035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.998132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"} {"level":"info","ts":"2026-10-17T10:52:56.605155Z","caller":"traceutil/trace.go:171","msg":"trace[1880298963] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2811; }","duration":"229.152706ms","start":"2026-10-17T10:52:56.375971Z","end":"2026-10-17T10:52:56.605124Z","steps":["trace[1880298963] 'agreement among raft nodes before linearized reading' (duration: 222.597341ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:56:32.335977Z","caller":"traceutil/trace.go:171","msg":"trace[372536346] transaction","detail":"{read_only:false; response_revision:4077; number_of_response:1; }","duration":"118.682545ms","start":"2026-10-17T10:56:32.217257Z","end":"2026-10-17T10:56:32.335939Z","steps":["trace[372536346] 'process raft request' (duration: 66.167141ms)","trace[372536346] 'compare' (duration: 51.856237ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:57:15.793238Z","caller":"traceutil/trace.go:171","msg":"trace[1318664243] transaction","detail":"{read_only:false; response_revision:4675; number_of_response:1; }","duration":"121.029997ms","start":"2026-10-17T10:57:15.672183Z","end":"2026-10-17T10:57:15.793213Z","steps":["trace[1318664243] 'process raft request' (duration: 113.426738ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:57:25.555906Z","caller":"traceutil/trace.go:171","msg":"trace[1798256287] transaction","detail":"{read_only:false; response_revision:4920; number_of_response:1; }","duration":"140.939788ms","start":"2026-10-17T10:57:25.414943Z","end":"2026-10-17T10:57:25.555883Z","steps":["trace[1798256287] 'process raft request' (duration: 140.771398ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:57:25.56457Z","caller":"traceutil/trace.go:171","msg":"trace[304252697] transaction","detail":"{read_only:false; response_revision:4921; number_of_response:1; }","duration":"140.526043ms","start":"2026-10-17T10:57:25.424021Z","end":"2026-10-17T10:57:25.564547Z","steps":["trace[304252697] 'process raft request' (duration: 140.405796ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:57:30.230086Z","caller":"traceutil/trace.go:171","msg":"trace[1088194818] transaction","detail":"{read_only:false; response_revision:5002; number_of_response:1; }","duration":"101.017717ms","start":"2026-10-17T10:57:30.129014Z","end":"2026-10-17T10:57:30.230032Z","steps":["trace[1088194818] 'process raft request' (duration: 100.690817ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:57:30.471242Z","caller":"traceutil/trace.go:171","msg":"trace[290917509] linearizableReadLoop","detail":"{readStateIndex:5197; appliedIndex:5196; }","duration":"174.071248ms","start":"2026-10-17T10:57:30.297151Z","end":"2026-10-17T10:57:30.471223Z","steps":["trace[290917509] 'read index received' (duration: 143.965995ms)","trace[290917509] 'applied index is now lower than readState.Index' (duration: 30.104323ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:57:30.471336Z","caller":"traceutil/trace.go:171","msg":"trace[1069404096] transaction","detail":"{read_only:false; response_revision:5005; number_of_response:1; }","duration":"233.601254ms","start":"2026-10-17T10:57:30.237723Z","end":"2026-10-17T10:57:30.471324Z","steps":["trace[1069404096] 'process raft request' (duration: 203.48779ms)","trace[1069404096] 'compare' (duration: 29.778464ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:57:30.47148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.256689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:57:30.471596Z","caller":"traceutil/trace.go:171","msg":"trace[901691966] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:5005; }","duration":"174.457261ms","start":"2026-10-17T10:57:30.297114Z","end":"2026-10-17T10:57:30.471571Z","steps":["trace[901691966] 'agreement among raft nodes before linearized reading' (duration: 174.215547ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:30.530003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.154318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12429"} {"level":"info","ts":"2026-10-17T10:57:30.530123Z","caller":"traceutil/trace.go:171","msg":"trace[36177983] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5006; }","duration":"163.329018ms","start":"2026-10-17T10:57:30.366773Z","end":"2026-10-17T10:57:30.530102Z","steps":["trace[36177983] 'agreement among raft nodes before linearized reading' (duration: 163.03061ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:57:44.213325Z","caller":"traceutil/trace.go:171","msg":"trace[532635183] transaction","detail":"{read_only:false; response_revision:5189; number_of_response:1; }","duration":"115.786004ms","start":"2026-10-17T10:57:44.097491Z","end":"2026-10-17T10:57:44.213277Z","steps":["trace[532635183] 'process raft request' (duration: 115.641695ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:57:44.230827Z","caller":"traceutil/trace.go:171","msg":"trace[341142328] linearizableReadLoop","detail":"{readStateIndex:5388; appliedIndex:5386; }","duration":"121.246822ms","start":"2026-10-17T10:57:44.109563Z","end":"2026-10-17T10:57:44.23081Z","steps":["trace[341142328] 'read index received' (duration: 103.534558ms)","trace[341142328] 'applied index is now lower than readState.Index' (duration: 17.711324ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:57:44.231069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.485796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-10-17T10:57:44.231108Z","caller":"traceutil/trace.go:171","msg":"trace[1541762112] transaction","detail":"{read_only:false; response_revision:5190; number_of_response:1; }","duration":"127.317666ms","start":"2026-10-17T10:57:44.103749Z","end":"2026-10-17T10:57:44.231066Z","steps":["trace[1541762112] 'process raft request' (duration: 126.979916ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:57:44.231215Z","caller":"traceutil/trace.go:171","msg":"trace[1398779878] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5190; }","duration":"121.595762ms","start":"2026-10-17T10:57:44.109539Z","end":"2026-10-17T10:57:44.231135Z","steps":["trace[1398779878] 'agreement among raft nodes before linearized reading' (duration: 121.404981ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:57:44.363384Z","caller":"traceutil/trace.go:171","msg":"trace[67624609] linearizableReadLoop","detail":"{readStateIndex:5389; appliedIndex:5388; }","duration":"115.679887ms","start":"2026-10-17T10:57:44.247683Z","end":"2026-10-17T10:57:44.363362Z","steps":["trace[67624609] 'read index received' (duration: 86.067319ms)","trace[67624609] 'applied index is now lower than readState.Index' (duration: 29.611418ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:57:44.363574Z","caller":"traceutil/trace.go:171","msg":"trace[52781292] transaction","detail":"{read_only:false; response_revision:5191; number_of_response:1; }","duration":"116.999877ms","start":"2026-10-17T10:57:44.24656Z","end":"2026-10-17T10:57:44.36356Z","steps":["trace[52781292] 'process raft request' (duration: 87.24677ms)","trace[52781292] 'compare' (duration: 29.443488ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:57:44.363852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.163546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18df4beaefe35629\" ","response":"range_response_count:1 size:746"} {"level":"info","ts":"2026-10-17T10:57:44.363926Z","caller":"traceutil/trace.go:171","msg":"trace[1447552464] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18df4beaefe35629; range_end:; response_count:1; response_revision:5191; }","duration":"116.280683ms","start":"2026-10-17T10:57:44.247633Z","end":"2026-10-17T10:57:44.363913Z","steps":["trace[1447552464] 'agreement among raft nodes before linearized reading' (duration: 116.073341ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:57:44.364225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.695078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1455"} {"level":"info","ts":"2026-10-17T10:57:44.364274Z","caller":"traceutil/trace.go:171","msg":"trace[630034783] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5191; }","duration":"114.790354ms","start":"2026-10-17T10:57:44.249471Z","end":"2026-10-17T10:57:44.364261Z","steps":["trace[630034783] 'agreement among raft nodes before linearized reading' (duration: 114.127904ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:57:44.697294Z","caller":"traceutil/trace.go:171","msg":"trace[976682295] transaction","detail":"{read_only:false; response_revision:5200; number_of_response:1; }","duration":"101.334846ms","start":"2026-10-17T10:57:44.595936Z","end":"2026-10-17T10:57:44.697271Z","steps":["trace[976682295] 'process raft request' (duration: 64.398228ms)","trace[976682295] 'compare' (duration: 36.735056ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:58:07.783493Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2868} {"level":"info","ts":"2026-10-17T10:58:07.858509Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2868,"took":"74.038728ms","hash":2595208335,"current-db-size-bytes":51654656,"current-db-size":"52 MB","current-db-size-in-use-bytes":28168192,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-17T10:58:07.858616Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2595208335,"revision":2868,"compact-revision":-1} {"level":"warn","ts":"2026-10-17T11:01:22.6611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.411249ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:01:22.661513Z","caller":"traceutil/trace.go:171","msg":"trace[320629248] linearizableReadLoop","detail":"{readStateIndex:7035; appliedIndex:7033; }","duration":"170.689217ms","start":"2026-10-17T11:01:22.490801Z","end":"2026-10-17T11:01:22.66149Z","steps":["trace[320629248] 'read index received' (duration: 20.799815ms)","trace[320629248] 'applied index is now lower than readState.Index' (duration: 149.884392ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:01:22.661573Z","caller":"traceutil/trace.go:171","msg":"trace[754995114] transaction","detail":"{read_only:false; response_revision:6785; number_of_response:1; }","duration":"221.629066ms","start":"2026-10-17T11:01:22.439907Z","end":"2026-10-17T11:01:22.661536Z","steps":["trace[754995114] 'process raft request' (duration: 221.312364ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:01:22.661667Z","caller":"traceutil/trace.go:171","msg":"trace[1677791480] transaction","detail":"{read_only:false; response_revision:6784; number_of_response:1; }","duration":"221.724256ms","start":"2026-10-17T11:01:22.439918Z","end":"2026-10-17T11:01:22.661642Z","steps":["trace[1677791480] 'process raft request' (duration: 71.673724ms)","trace[1677791480] 'compare' (duration: 149.243228ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:01:22.66173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.917868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4840"} {"level":"info","ts":"2026-10-17T11:01:22.661774Z","caller":"traceutil/trace.go:171","msg":"trace[879596127] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6785; }","duration":"170.994738ms","start":"2026-10-17T11:01:22.490766Z","end":"2026-10-17T11:01:22.661761Z","steps":["trace[879596127] 'agreement among raft nodes before linearized reading' (duration: 170.845567ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:01:44.556681Z","caller":"traceutil/trace.go:171","msg":"trace[436862405] transaction","detail":"{read_only:false; response_revision:6947; number_of_response:1; }","duration":"100.6766ms","start":"2026-10-17T11:01:44.45597Z","end":"2026-10-17T11:01:44.556647Z","steps":["trace[436862405] 'process raft request' (duration: 100.453878ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:03:07.791709Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5352} {"level":"info","ts":"2026-10-17T11:03:07.876483Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5352,"took":"83.683605ms","hash":1774405720,"current-db-size-bytes":51654656,"current-db-size":"52 MB","current-db-size-in-use-bytes":18763776,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-17T11:03:07.876588Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1774405720,"revision":5352,"compact-revision":2868}