{"level":"warn","ts":"2026-10-17T10:50:03.702507Z","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:50:03.702663Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.25: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.25:2380","--initial-cluster=instance=https://162.253.55.25:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.25:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.25: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:50:03.702797Z","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:50:03.702821Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.25:2380"]} {"level":"info","ts":"2026-10-17T10:50:03.702877Z","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:50:03.704139Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.25:2379"]} {"level":"info","ts":"2026-10-17T10:50:03.704281Z","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://162.253.55.25:2380"],"listen-peer-urls":["https://162.253.55.25:2380"],"advertise-client-urls":["https://162.253.55.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.25: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:50:03.707902Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.24719ms"} {"level":"info","ts":"2026-10-17T10:50:03.715311Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"afeb1bf8b692f9e8","cluster-id":"6bfcc13baae99738"} {"level":"info","ts":"2026-10-17T10:50:03.715437Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 switched to configuration voters=()"} {"level":"info","ts":"2026-10-17T10:50:03.715465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 became follower at term 0"} {"level":"info","ts":"2026-10-17T10:50:03.715478Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft afeb1bf8b692f9e8 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-17T10:50:03.715496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 became follower at term 1"} {"level":"info","ts":"2026-10-17T10:50:03.715549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 switched to configuration voters=(12676256331193317864)"} {"level":"warn","ts":"2026-10-17T10:50:03.723569Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-17T10:50:03.725673Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-17T10:50:03.727387Z","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:50:03.730476Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"afeb1bf8b692f9e8","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-17T10:50:03.730735Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"afeb1bf8b692f9e8","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-17T10:50:03.73095Z","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:50:03.731073Z","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:50:03.731087Z","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:50:03.733222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 switched to configuration voters=(12676256331193317864)"} {"level":"info","ts":"2026-10-17T10:50:03.733451Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6bfcc13baae99738","local-member-id":"afeb1bf8b692f9e8","added-peer-id":"afeb1bf8b692f9e8","added-peer-peer-urls":["https://162.253.55.25:2380"]} {"level":"info","ts":"2026-10-17T10:50:03.735294Z","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:50:03.735633Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"afeb1bf8b692f9e8","initial-advertise-peer-urls":["https://162.253.55.25:2380"],"listen-peer-urls":["https://162.253.55.25:2380"],"advertise-client-urls":["https://162.253.55.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-17T10:50:03.735661Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-17T10:50:03.735362Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.25:2380"} {"level":"info","ts":"2026-10-17T10:50:03.735687Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.25:2380"} {"level":"info","ts":"2026-10-17T10:50:04.016216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 is starting a new election at term 1"} {"level":"info","ts":"2026-10-17T10:50:04.016286Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-17T10:50:04.016309Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 received MsgPreVoteResp from afeb1bf8b692f9e8 at term 1"} {"level":"info","ts":"2026-10-17T10:50:04.016329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 became candidate at term 2"} {"level":"info","ts":"2026-10-17T10:50:04.01634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 received MsgVoteResp from afeb1bf8b692f9e8 at term 2"} {"level":"info","ts":"2026-10-17T10:50:04.016354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 became leader at term 2"} {"level":"info","ts":"2026-10-17T10:50:04.016368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: afeb1bf8b692f9e8 elected leader afeb1bf8b692f9e8 at term 2"} {"level":"info","ts":"2026-10-17T10:50:04.017546Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"afeb1bf8b692f9e8","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.25:2379]}","request-path":"/0/members/afeb1bf8b692f9e8/attributes","cluster-id":"6bfcc13baae99738","publish-timeout":"7s"} {"level":"info","ts":"2026-10-17T10:50:04.01761Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T10:50:04.01784Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T10:50:04.018191Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-17T10:50:04.018221Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-17T10:50:04.020819Z","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:50:04.020988Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:50:04.023767Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.25:2379"} {"level":"info","ts":"2026-10-17T10:50:04.024376Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6bfcc13baae99738","local-member-id":"afeb1bf8b692f9e8","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:50:04.024481Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:50:04.024518Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:50:54.429506Z","caller":"traceutil/trace.go:171","msg":"trace[1812541978] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:631; }","duration":"222.979583ms","start":"2026-10-17T10:50:54.206505Z","end":"2026-10-17T10:50:54.429485Z","steps":["trace[1812541978] 'read index received' (duration: 222.24259ms)","trace[1812541978] 'applied index is now lower than readState.Index' (duration: 736.123µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:50:54.429606Z","caller":"traceutil/trace.go:171","msg":"trace[1064927723] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"233.432486ms","start":"2026-10-17T10:50:54.19614Z","end":"2026-10-17T10:50:54.429572Z","steps":["trace[1064927723] 'process raft request' (duration: 232.818045ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:50:54.429796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.31168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-17T10:50:54.429891Z","caller":"traceutil/trace.go:171","msg":"trace[606553166] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:606; }","duration":"129.445874ms","start":"2026-10-17T10:50:54.300433Z","end":"2026-10-17T10:50:54.429879Z","steps":["trace[606553166] 'agreement among raft nodes before linearized reading' (duration: 129.257389ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:50:54.429885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.026201ms","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:50:54.42995Z","caller":"traceutil/trace.go:171","msg":"trace[394512631] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:606; }","duration":"125.107903ms","start":"2026-10-17T10:50:54.304824Z","end":"2026-10-17T10:50:54.429932Z","steps":["trace[394512631] 'agreement among raft nodes before linearized reading' (duration: 124.945819ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:50:54.430649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.118545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5sjtv\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-10-17T10:50:54.430751Z","caller":"traceutil/trace.go:171","msg":"trace[298869497] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5sjtv; range_end:; response_count:1; response_revision:606; }","duration":"224.274178ms","start":"2026-10-17T10:50:54.206453Z","end":"2026-10-17T10:50:54.430727Z","steps":["trace[298869497] 'agreement among raft nodes before linearized reading' (duration: 223.209838ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:50:54.999209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.044616ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T10:50:54.999478Z","caller":"traceutil/trace.go:171","msg":"trace[1640710365] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"565.714581ms","start":"2026-10-17T10:50:54.433724Z","end":"2026-10-17T10:50:54.999438Z","steps":["trace[1640710365] 'process raft request' (duration: 85.701827ms)","trace[1640710365] 'compare' (duration: 478.781641ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:50:54.999523Z","caller":"traceutil/trace.go:171","msg":"trace[115403359] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:632; }","duration":"541.082248ms","start":"2026-10-17T10:50:54.458424Z","end":"2026-10-17T10:50:54.999506Z","steps":["trace[115403359] 'read index received' (duration: 61.065144ms)","trace[115403359] 'applied index is now lower than readState.Index' (duration: 480.015814ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:50:54.999651Z","caller":"traceutil/trace.go:171","msg":"trace[1644099652] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"495.854946ms","start":"2026-10-17T10:50:54.503787Z","end":"2026-10-17T10:50:54.999642Z","steps":["trace[1644099652] 'process raft request' (duration: 495.679673ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:50:54.999712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:50:54.50376Z","time spent":"495.916397ms","remote":"127.0.0.1:33836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-17T10:50:54.999817Z","caller":"traceutil/trace.go:171","msg":"trace[1493655444] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"565.189633ms","start":"2026-10-17T10:50:54.434593Z","end":"2026-10-17T10:50:54.999782Z","steps":["trace[1493655444] 'process raft request' (duration: 564.740355ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:50:54.999812Z","caller":"traceutil/trace.go:171","msg":"trace[1130123822] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"550.996431ms","start":"2026-10-17T10:50:54.448779Z","end":"2026-10-17T10:50:54.999775Z","steps":["trace[1130123822] 'process raft request' (duration: 550.644104ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:50:54.99989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.465854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-10-17T10:50:54.999899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:50:54.434571Z","time spent":"565.290014ms","remote":"127.0.0.1:33754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:50:54.999948Z","caller":"traceutil/trace.go:171","msg":"trace[1227868740] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:610; }","duration":"541.558836ms","start":"2026-10-17T10:50:54.45837Z","end":"2026-10-17T10:50:54.999929Z","steps":["trace[1227868740] 'agreement among raft nodes before linearized reading' (duration: 541.21527ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:50:54.999983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:50:54.458353Z","time spent":"541.621767ms","remote":"127.0.0.1:33754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-17T10:50:55.000006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:50:54.448714Z","time spent":"551.184864ms","remote":"127.0.0.1:40126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:50:54.999677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:50:54.433699Z","time spent":"565.875865ms","remote":"127.0.0.1:33754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:50:56.463072Z","caller":"traceutil/trace.go:171","msg":"trace[524955425] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"105.834257ms","start":"2026-10-17T10:50:56.357217Z","end":"2026-10-17T10:50:56.463051Z","steps":["trace[524955425] 'process raft request' (duration: 105.775036ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:50:56.463097Z","caller":"traceutil/trace.go:171","msg":"trace[973449772] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"109.161319ms","start":"2026-10-17T10:50:56.353912Z","end":"2026-10-17T10:50:56.463073Z","steps":["trace[973449772] 'process raft request' (duration: 106.147043ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:52:25.885983Z","caller":"traceutil/trace.go:171","msg":"trace[1044072653] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"406.360953ms","start":"2026-10-17T10:52:25.479594Z","end":"2026-10-17T10:52:25.885955Z","steps":["trace[1044072653] 'process raft request' (duration: 406.179908ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:52:25.886285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:52:25.479563Z","time spent":"406.627988ms","remote":"127.0.0.1:33754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:52:26.335809Z","caller":"traceutil/trace.go:171","msg":"trace[1249326662] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"855.73962ms","start":"2026-10-17T10:52:25.480036Z","end":"2026-10-17T10:52:26.335776Z","steps":["trace[1249326662] 'process raft request' (duration: 821.845072ms)","trace[1249326662] 'compare' (duration: 33.643803ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:52:26.335829Z","caller":"traceutil/trace.go:171","msg":"trace[457421233] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"721.344272ms","start":"2026-10-17T10:52:25.614453Z","end":"2026-10-17T10:52:26.335797Z","steps":["trace[457421233] 'process raft request' (duration: 721.23046ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:52:26.335985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:52:25.480011Z","time spent":"855.879993ms","remote":"127.0.0.1:33754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:52:26.336118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:52:25.614435Z","time spent":"721.481294ms","remote":"127.0.0.1:33754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:52:26.336174Z","caller":"traceutil/trace.go:171","msg":"trace[1001350751] linearizableReadLoop","detail":"{readStateIndex:1904; appliedIndex:1902; }","duration":"800.414836ms","start":"2026-10-17T10:52:25.535698Z","end":"2026-10-17T10:52:26.336112Z","steps":["trace[1001350751] 'read index received' (duration: 350.004068ms)","trace[1001350751] 'applied index is now lower than readState.Index' (duration: 450.408488ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:52:26.336228Z","caller":"traceutil/trace.go:171","msg":"trace[1172215913] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"477.107991ms","start":"2026-10-17T10:52:25.859072Z","end":"2026-10-17T10:52:26.33618Z","steps":["trace[1172215913] 'process raft request' (duration: 476.673613ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:52:26.336442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.724221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-10-17T10:52:26.336443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:52:25.859055Z","time spent":"477.276435ms","remote":"127.0.0.1:33754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:52:26.336487Z","caller":"traceutil/trace.go:171","msg":"trace[1642117704] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1833; }","duration":"800.813152ms","start":"2026-10-17T10:52:25.535662Z","end":"2026-10-17T10:52:26.336475Z","steps":["trace[1642117704] 'agreement among raft nodes before linearized reading' (duration: 800.621299ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:52:26.336524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:52:25.535638Z","time spent":"800.878315ms","remote":"127.0.0.1:33754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-17T10:52:26.336529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"792.612322ms","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-10-17T10:52:26.336633Z","caller":"traceutil/trace.go:171","msg":"trace[1441255581] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1833; }","duration":"792.745364ms","start":"2026-10-17T10:52:25.543867Z","end":"2026-10-17T10:52:26.336612Z","steps":["trace[1441255581] 'agreement among raft nodes before linearized reading' (duration: 792.454368ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:52:26.33664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.736365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c1f3e09f-1a51-4ae5-9918-f38a4afcbabb\" ","response":"range_response_count:1 size:3626"} {"level":"warn","ts":"2026-10-17T10:52:26.336682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:52:25.543853Z","time spent":"792.817505ms","remote":"127.0.0.1:33754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-17T10:52:26.33673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.638715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-17T10:52:26.336743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.719207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5700"} {"level":"info","ts":"2026-10-17T10:52:26.336755Z","caller":"traceutil/trace.go:171","msg":"trace[144774217] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1833; }","duration":"132.695646ms","start":"2026-10-17T10:52:26.204052Z","end":"2026-10-17T10:52:26.336748Z","steps":["trace[144774217] 'agreement among raft nodes before linearized reading' (duration: 132.656095ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:52:26.336778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"723.088165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c1f3e09f-1a51-4ae5-9918-f38a4afcbabb\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-10-17T10:52:26.336691Z","caller":"traceutil/trace.go:171","msg":"trace[1267622742] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c1f3e09f-1a51-4ae5-9918-f38a4afcbabb; range_end:; response_count:1; response_revision:1833; }","duration":"650.829557ms","start":"2026-10-17T10:52:25.685844Z","end":"2026-10-17T10:52:26.336673Z","steps":["trace[1267622742] 'agreement among raft nodes before linearized reading' (duration: 650.632873ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:52:26.336806Z","caller":"traceutil/trace.go:171","msg":"trace[1704374991] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1833; }","duration":"682.806428ms","start":"2026-10-17T10:52:25.653981Z","end":"2026-10-17T10:52:26.336787Z","steps":["trace[1704374991] 'agreement among raft nodes before linearized reading' (duration: 682.650125ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:52:26.336812Z","caller":"traceutil/trace.go:171","msg":"trace[1481634564] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c1f3e09f-1a51-4ae5-9918-f38a4afcbabb; range_end:; response_count:1; response_revision:1833; }","duration":"723.144935ms","start":"2026-10-17T10:52:25.613654Z","end":"2026-10-17T10:52:26.336799Z","steps":["trace[1481634564] 'agreement among raft nodes before linearized reading' (duration: 723.045173ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:52:26.336855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:52:25.613628Z","time spent":"723.220537ms","remote":"127.0.0.1:40126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c1f3e09f-1a51-4ae5-9918-f38a4afcbabb\" "} {"level":"warn","ts":"2026-10-17T10:52:26.336858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:52:25.653968Z","time spent":"682.878049ms","remote":"127.0.0.1:37474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5723,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-10-17T10:52:26.336893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:52:25.685809Z","time spent":"651.067981ms","remote":"127.0.0.1:40126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c1f3e09f-1a51-4ae5-9918-f38a4afcbabb\" "} {"level":"warn","ts":"2026-10-17T10:53:21.209032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.211054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:53:21.209136Z","caller":"traceutil/trace.go:171","msg":"trace[750257750] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:2189; }","duration":"201.389987ms","start":"2026-10-17T10:53:21.007726Z","end":"2026-10-17T10:53:21.209116Z","steps":["trace[750257750] 'count revisions from in-memory index tree' (duration: 201.01951ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:54:45.6682Z","caller":"traceutil/trace.go:171","msg":"trace[1244653871] transaction","detail":"{read_only:false; response_revision:2838; number_of_response:1; }","duration":"160.628311ms","start":"2026-10-17T10:54:45.507535Z","end":"2026-10-17T10:54:45.668164Z","steps":["trace[1244653871] 'process raft request' (duration: 160.361616ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:54:45.677536Z","caller":"traceutil/trace.go:171","msg":"trace[128792422] transaction","detail":"{read_only:false; response_revision:2839; number_of_response:1; }","duration":"123.362313ms","start":"2026-10-17T10:54:45.554147Z","end":"2026-10-17T10:54:45.67751Z","steps":["trace[128792422] 'process raft request' (duration: 123.22962ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:54:45.831958Z","caller":"traceutil/trace.go:171","msg":"trace[1028293391] transaction","detail":"{read_only:false; response_revision:2840; number_of_response:1; }","duration":"115.944114ms","start":"2026-10-17T10:54:45.715988Z","end":"2026-10-17T10:54:45.831932Z","steps":["trace[1028293391] 'process raft request' (duration: 115.785351ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:58:04.357994Z","caller":"traceutil/trace.go:171","msg":"trace[457788664] transaction","detail":"{read_only:false; response_revision:4079; number_of_response:1; }","duration":"120.229505ms","start":"2026-10-17T10:58:04.23774Z","end":"2026-10-17T10:58:04.35797Z","steps":["trace[457788664] 'process raft request' (duration: 120.189304ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:58:04.358212Z","caller":"traceutil/trace.go:171","msg":"trace[31691189] transaction","detail":"{read_only:false; response_revision:4078; number_of_response:1; }","duration":"254.112043ms","start":"2026-10-17T10:58:04.104085Z","end":"2026-10-17T10:58:04.358197Z","steps":["trace[31691189] 'process raft request' (duration: 205.362116ms)","trace[31691189] 'compare' (duration: 48.35553ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:58:04.358486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.202147ms","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:58:04.358297Z","caller":"traceutil/trace.go:171","msg":"trace[844889870] linearizableReadLoop","detail":"{readStateIndex:4234; appliedIndex:4233; }","duration":"251.997103ms","start":"2026-10-17T10:58:04.106269Z","end":"2026-10-17T10:58:04.358266Z","steps":["trace[844889870] 'read index received' (duration: 32.965623ms)","trace[844889870] 'applied index is now lower than readState.Index' (duration: 219.02935ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:58:04.358668Z","caller":"traceutil/trace.go:171","msg":"trace[1728250811] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4079; }","duration":"252.41384ms","start":"2026-10-17T10:58:04.106238Z","end":"2026-10-17T10:58:04.358652Z","steps":["trace[1728250811] 'agreement among raft nodes before linearized reading' (duration: 252.084074ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:04.358758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.492124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:58:04.358793Z","caller":"traceutil/trace.go:171","msg":"trace[1727261389] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4079; }","duration":"159.548185ms","start":"2026-10-17T10:58:04.199234Z","end":"2026-10-17T10:58:04.358782Z","steps":["trace[1727261389] 'agreement among raft nodes before linearized reading' (duration: 159.501865ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:59:42.156345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.950256ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T10:59:42.156519Z","caller":"traceutil/trace.go:171","msg":"trace[1776189572] transaction","detail":"{read_only:false; response_revision:5172; number_of_response:1; }","duration":"133.968569ms","start":"2026-10-17T10:59:42.022536Z","end":"2026-10-17T10:59:42.156505Z","steps":["trace[1776189572] 'process raft request' (duration: 32.776549ms)","trace[1776189572] 'compare' (duration: 100.821484ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:59:42.15665Z","caller":"traceutil/trace.go:171","msg":"trace[887308192] transaction","detail":"{read_only:false; response_revision:5173; number_of_response:1; }","duration":"111.491182ms","start":"2026-10-17T10:59:42.045152Z","end":"2026-10-17T10:59:42.156643Z","steps":["trace[887308192] 'process raft request' (duration: 111.269998ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:59:46.359809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.364111ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T10:59:46.359946Z","caller":"traceutil/trace.go:171","msg":"trace[97230813] linearizableReadLoop","detail":"{readStateIndex:5549; appliedIndex:5547; }","duration":"168.931588ms","start":"2026-10-17T10:59:46.190991Z","end":"2026-10-17T10:59:46.359923Z","steps":["trace[97230813] 'read index received' (duration: 6.246595ms)","trace[97230813] 'applied index is now lower than readState.Index' (duration: 162.683133ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:59:46.359993Z","caller":"traceutil/trace.go:171","msg":"trace[1567754170] transaction","detail":"{read_only:false; response_revision:5346; number_of_response:1; }","duration":"190.137833ms","start":"2026-10-17T10:59:46.169814Z","end":"2026-10-17T10:59:46.359952Z","steps":["trace[1567754170] 'process raft request' (duration: 37.400505ms)","trace[1567754170] 'compare' (duration: 152.171728ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:59:46.360309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.64344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:59:46.360356Z","caller":"traceutil/trace.go:171","msg":"trace[1581415050] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5346; }","duration":"157.765291ms","start":"2026-10-17T10:59:46.202576Z","end":"2026-10-17T10:59:46.360342Z","steps":["trace[1581415050] 'agreement among raft nodes before linearized reading' (duration: 157.644799ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:59:46.360725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.730224ms","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:59:46.360779Z","caller":"traceutil/trace.go:171","msg":"trace[2006060005] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5346; }","duration":"169.821856ms","start":"2026-10-17T10:59:46.190941Z","end":"2026-10-17T10:59:46.360763Z","steps":["trace[2006060005] 'agreement among raft nodes before linearized reading' (duration: 169.097742ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:00:04.142938Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2941} {"level":"info","ts":"2026-10-17T11:00:04.221912Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2941,"took":"77.426157ms","hash":885609800,"current-db-size-bytes":55689216,"current-db-size":"56 MB","current-db-size-in-use-bytes":30957568,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T11:00:04.22198Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":885609800,"revision":2941,"compact-revision":-1} {"level":"info","ts":"2026-10-17T11:00:20.643098Z","caller":"traceutil/trace.go:171","msg":"trace[668929207] linearizableReadLoop","detail":"{readStateIndex:6124; appliedIndex:6122; }","duration":"278.557886ms","start":"2026-10-17T11:00:20.364512Z","end":"2026-10-17T11:00:20.64307Z","steps":["trace[668929207] 'read index received' (duration: 565.29µs)","trace[668929207] 'applied index is now lower than readState.Index' (duration: 277.991486ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:00:20.643237Z","caller":"traceutil/trace.go:171","msg":"trace[1028636053] transaction","detail":"{read_only:false; response_revision:5906; number_of_response:1; }","duration":"293.036085ms","start":"2026-10-17T11:00:20.350153Z","end":"2026-10-17T11:00:20.643189Z","steps":["trace[1028636053] 'process raft request' (duration: 292.74889ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:00:20.643321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.78673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-10-17T11:00:20.643429Z","caller":"traceutil/trace.go:171","msg":"trace[1959777300] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5906; }","duration":"278.941113ms","start":"2026-10-17T11:00:20.364472Z","end":"2026-10-17T11:00:20.643413Z","steps":["trace[1959777300] 'agreement among raft nodes before linearized reading' (duration: 278.719229ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:00:20.647614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.432132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-17T11:00:20.647865Z","caller":"traceutil/trace.go:171","msg":"trace[604210439] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5907; }","duration":"117.691517ms","start":"2026-10-17T11:00:20.530156Z","end":"2026-10-17T11:00:20.647847Z","steps":["trace[604210439] 'agreement among raft nodes before linearized reading' (duration: 117.29319ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:00:20.648096Z","caller":"traceutil/trace.go:171","msg":"trace[1154623405] transaction","detail":"{read_only:false; response_revision:5907; number_of_response:1; }","duration":"135.64075ms","start":"2026-10-17T11:00:20.512409Z","end":"2026-10-17T11:00:20.64805Z","steps":["trace[1154623405] 'process raft request' (duration: 134.924916ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:01:00.570766Z","caller":"traceutil/trace.go:171","msg":"trace[1833069227] transaction","detail":"{read_only:false; response_revision:6272; number_of_response:1; }","duration":"122.80282ms","start":"2026-10-17T11:01:00.447927Z","end":"2026-10-17T11:01:00.57073Z","steps":["trace[1833069227] 'process raft request' (duration: 122.476084ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:05:04.150539Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5647} {"level":"info","ts":"2026-10-17T11:05:04.234263Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5647,"took":"81.932059ms","hash":801722044,"current-db-size-bytes":55689216,"current-db-size":"56 MB","current-db-size-in-use-bytes":25571328,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-17T11:05:04.234379Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":801722044,"revision":5647,"compact-revision":2941} {"level":"warn","ts":"2026-10-17T11:06:20.996674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.082464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-17T11:06:20.996783Z","caller":"traceutil/trace.go:171","msg":"trace[141716822] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:8629; }","duration":"167.251578ms","start":"2026-10-17T11:06:20.829515Z","end":"2026-10-17T11:06:20.996766Z","steps":["trace[141716822] 'count revisions from in-memory index tree' (duration: 167.027883ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:06:21.230802Z","caller":"traceutil/trace.go:171","msg":"trace[1687180266] linearizableReadLoop","detail":"{readStateIndex:8934; appliedIndex:8933; }","duration":"299.709626ms","start":"2026-10-17T11:06:20.93106Z","end":"2026-10-17T11:06:21.23077Z","steps":["trace[1687180266] 'read index received' (duration: 299.517702ms)","trace[1687180266] 'applied index is now lower than readState.Index' (duration: 190.944µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:06:21.230862Z","caller":"traceutil/trace.go:171","msg":"trace[477864568] transaction","detail":"{read_only:false; response_revision:8630; number_of_response:1; }","duration":"308.868154ms","start":"2026-10-17T11:06:20.92196Z","end":"2026-10-17T11:06:21.230828Z","steps":["trace[477864568] 'process raft request' (duration: 308.64408ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:06:21.231026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:06:20.921931Z","time spent":"309.010077ms","remote":"127.0.0.1:33754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:06:21.231124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.062062ms","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-10-17T11:06:21.231212Z","caller":"traceutil/trace.go:171","msg":"trace[1787255525] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8630; }","duration":"300.148683ms","start":"2026-10-17T11:06:20.93104Z","end":"2026-10-17T11:06:21.231189Z","steps":["trace[1787255525] 'agreement among raft nodes before linearized reading' (duration: 299.838698ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:06:21.231259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:06:20.930978Z","time spent":"300.267616ms","remote":"127.0.0.1:33754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-17T11:06:21.239954Z","caller":"traceutil/trace.go:171","msg":"trace[2072677081] transaction","detail":"{read_only:false; response_revision:8631; number_of_response:1; }","duration":"238.490659ms","start":"2026-10-17T11:06:21.001443Z","end":"2026-10-17T11:06:21.239934Z","steps":["trace[2072677081] 'process raft request' (duration: 238.322386ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:06:21.239973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.780451ms","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-10-17T11:06:21.240025Z","caller":"traceutil/trace.go:171","msg":"trace[1820932873] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8631; }","duration":"303.831911ms","start":"2026-10-17T11:06:20.936178Z","end":"2026-10-17T11:06:21.24001Z","steps":["trace[1820932873] 'agreement among raft nodes before linearized reading' (duration: 303.696709ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:06:21.240056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:06:20.936132Z","time spent":"303.912973ms","remote":"127.0.0.1:33754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-10-17T11:06:33.404126Z","caller":"traceutil/trace.go:171","msg":"trace[1472324628] transaction","detail":"{read_only:false; response_revision:8693; number_of_response:1; }","duration":"100.306396ms","start":"2026-10-17T11:06:33.303788Z","end":"2026-10-17T11:06:33.404094Z","steps":["trace[1472324628] 'process raft request' (duration: 100.05933ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:06:33.53006Z","caller":"traceutil/trace.go:171","msg":"trace[905668948] transaction","detail":"{read_only:false; response_revision:8695; number_of_response:1; }","duration":"121.884393ms","start":"2026-10-17T11:06:33.408153Z","end":"2026-10-17T11:06:33.530038Z","steps":["trace[905668948] 'process raft request' (duration: 84.331732ms)","trace[905668948] 'compare' (duration: 37.455799ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:06:33.950272Z","caller":"traceutil/trace.go:171","msg":"trace[1539541588] transaction","detail":"{read_only:false; response_revision:8697; number_of_response:1; }","duration":"114.024948ms","start":"2026-10-17T11:06:33.836226Z","end":"2026-10-17T11:06:33.950251Z","steps":["trace[1539541588] 'process raft request' (duration: 113.884786ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:07:03.710525Z","caller":"traceutil/trace.go:171","msg":"trace[661202112] transaction","detail":"{read_only:false; response_revision:8908; number_of_response:1; }","duration":"138.621108ms","start":"2026-10-17T11:07:03.571876Z","end":"2026-10-17T11:07:03.710497Z","steps":["trace[661202112] 'process raft request' (duration: 138.266912ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:07:05.90599Z","caller":"traceutil/trace.go:171","msg":"trace[1036079183] transaction","detail":"{read_only:false; response_revision:8920; number_of_response:1; }","duration":"102.443568ms","start":"2026-10-17T11:07:05.803522Z","end":"2026-10-17T11:07:05.905966Z","steps":["trace[1036079183] 'process raft request' (duration: 84.558346ms)","trace[1036079183] 'compare' (duration: 17.75778ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:07:05.906119Z","caller":"traceutil/trace.go:171","msg":"trace[1005514712] transaction","detail":"{read_only:false; response_revision:8921; number_of_response:1; }","duration":"101.784556ms","start":"2026-10-17T11:07:05.804317Z","end":"2026-10-17T11:07:05.906102Z","steps":["trace[1005514712] 'process raft request' (duration: 101.608813ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:07:12.922155Z","caller":"traceutil/trace.go:171","msg":"trace[868523588] transaction","detail":"{read_only:false; response_revision:8959; number_of_response:1; }","duration":"106.425591ms","start":"2026-10-17T11:07:12.815706Z","end":"2026-10-17T11:07:12.922131Z","steps":["trace[868523588] 'process raft request' (duration: 106.213207ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:07:13.186066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.198548ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-10-17T11:07:13.186161Z","caller":"traceutil/trace.go:171","msg":"trace[1070387450] linearizableReadLoop","detail":"{readStateIndex:9277; appliedIndex:9276; }","duration":"204.512599ms","start":"2026-10-17T11:07:12.98163Z","end":"2026-10-17T11:07:13.186143Z","steps":["trace[1070387450] 'read index received' (duration: 31.148367ms)","trace[1070387450] 'applied index is now lower than readState.Index' (duration: 173.362632ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:07:13.18632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.686794ms","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-17T11:07:13.186554Z","caller":"traceutil/trace.go:171","msg":"trace[752082505] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8959; }","duration":"204.964678ms","start":"2026-10-17T11:07:12.981577Z","end":"2026-10-17T11:07:13.186541Z","steps":["trace[752082505] 'agreement among raft nodes before linearized reading' (duration: 204.612391ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:07:16.27163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.490021ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:07:16.271811Z","caller":"traceutil/trace.go:171","msg":"trace[1941413334] linearizableReadLoop","detail":"{readStateIndex:9306; appliedIndex:9304; }","duration":"161.281598ms","start":"2026-10-17T11:07:16.110513Z","end":"2026-10-17T11:07:16.271794Z","steps":["trace[1941413334] 'read index received' (duration: 29.241872ms)","trace[1941413334] 'applied index is now lower than readState.Index' (duration: 132.038816ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:07:16.272024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.685445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nhmc7\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-10-17T11:07:16.272064Z","caller":"traceutil/trace.go:171","msg":"trace[398030608] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nhmc7; range_end:; response_count:1; response_revision:8989; }","duration":"161.752857ms","start":"2026-10-17T11:07:16.110299Z","end":"2026-10-17T11:07:16.272052Z","steps":["trace[398030608] 'agreement among raft nodes before linearized reading' (duration: 161.595474ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:07:16.27206Z","caller":"traceutil/trace.go:171","msg":"trace[1405362492] transaction","detail":"{read_only:false; response_revision:8989; number_of_response:1; }","duration":"147.468023ms","start":"2026-10-17T11:07:16.124502Z","end":"2026-10-17T11:07:16.27197Z","steps":["trace[1405362492] 'process raft request' (duration: 147.226928ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:07:16.272492Z","caller":"traceutil/trace.go:171","msg":"trace[1390589859] transaction","detail":"{read_only:false; response_revision:8988; number_of_response:1; }","duration":"176.686754ms","start":"2026-10-17T11:07:16.095785Z","end":"2026-10-17T11:07:16.272472Z","steps":["trace[1390589859] 'process raft request' (duration: 67.261076ms)","trace[1390589859] 'compare' (duration: 108.305097ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:07:31.035376Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024f3.wal"} {"level":"info","ts":"2026-10-17T11:08:19.288552Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"afeb1bf8b692f9e8","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T11:08:19.29673Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-17T11:08:19.296845Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-17T11:08:41.067064Z","caller":"traceutil/trace.go:171","msg":"trace[1864606285] transaction","detail":"{read_only:false; response_revision:9815; number_of_response:1; }","duration":"100.782997ms","start":"2026-10-17T11:08:40.966253Z","end":"2026-10-17T11:08:41.067036Z","steps":["trace[1864606285] 'process raft request' (duration: 100.559003ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:08:41.361053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.047392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:08:41.361173Z","caller":"traceutil/trace.go:171","msg":"trace[608404831] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:9815; }","duration":"176.239855ms","start":"2026-10-17T11:08:41.184912Z","end":"2026-10-17T11:08:41.361152Z","steps":["trace[608404831] 'count revisions from in-memory index tree' (duration: 175.95265ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:08:41.360905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.098794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:08:41.361485Z","caller":"traceutil/trace.go:171","msg":"trace[2040691838] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9815; }","duration":"161.720936ms","start":"2026-10-17T11:08:41.19974Z","end":"2026-10-17T11:08:41.361461Z","steps":["trace[2040691838] 'range keys from in-memory index tree' (duration: 161.021103ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:10:04.157168Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7992} {"level":"info","ts":"2026-10-17T11:10:04.246262Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7992,"took":"85.735632ms","hash":740873898,"current-db-size-bytes":55689216,"current-db-size":"56 MB","current-db-size-in-use-bytes":25501696,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-17T11:10:04.246524Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":740873898,"revision":7992,"compact-revision":5647} {"level":"info","ts":"2026-10-17T11:12:29.770259Z","caller":"traceutil/trace.go:171","msg":"trace[1937393605] transaction","detail":"{read_only:false; response_revision:11686; number_of_response:1; }","duration":"190.119341ms","start":"2026-10-17T11:12:29.580114Z","end":"2026-10-17T11:12:29.770234Z","steps":["trace[1937393605] 'process raft request' (duration: 189.998329ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:12:29.778488Z","caller":"traceutil/trace.go:171","msg":"trace[601041444] linearizableReadLoop","detail":"{readStateIndex:12086; appliedIndex:12085; }","duration":"150.144298ms","start":"2026-10-17T11:12:29.628303Z","end":"2026-10-17T11:12:29.778448Z","steps":["trace[601041444] 'read index received' (duration: 141.973636ms)","trace[601041444] 'applied index is now lower than readState.Index' (duration: 8.169472ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:12:29.778544Z","caller":"traceutil/trace.go:171","msg":"trace[64908296] transaction","detail":"{read_only:false; response_revision:11687; number_of_response:1; }","duration":"168.537829ms","start":"2026-10-17T11:12:29.609981Z","end":"2026-10-17T11:12:29.778519Z","steps":["trace[64908296] 'process raft request' (duration: 168.276064ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:12:29.778698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.358232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-10-17T11:12:29.778703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.380022ms","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-10-17T11:12:29.778735Z","caller":"traceutil/trace.go:171","msg":"trace[481936354] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11687; }","duration":"150.431453ms","start":"2026-10-17T11:12:29.628294Z","end":"2026-10-17T11:12:29.778725Z","steps":["trace[481936354] 'agreement among raft nodes before linearized reading' (duration: 150.29343ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:12:29.778762Z","caller":"traceutil/trace.go:171","msg":"trace[52215746] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:11687; }","duration":"150.474473ms","start":"2026-10-17T11:12:29.628271Z","end":"2026-10-17T11:12:29.778746Z","steps":["trace[52215746] 'agreement among raft nodes before linearized reading' (duration: 150.2932ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:12:29.778913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.594479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-10-17T11:12:29.778972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.059949ms","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-10-17T11:12:29.779008Z","caller":"traceutil/trace.go:171","msg":"trace[2144260150] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11687; }","duration":"127.760922ms","start":"2026-10-17T11:12:29.65122Z","end":"2026-10-17T11:12:29.778981Z","steps":["trace[2144260150] 'agreement among raft nodes before linearized reading' (duration: 127.481646ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:12:29.779112Z","caller":"traceutil/trace.go:171","msg":"trace[378363255] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:11687; }","duration":"120.15177ms","start":"2026-10-17T11:12:29.65886Z","end":"2026-10-17T11:12:29.779011Z","steps":["trace[378363255] 'agreement among raft nodes before linearized reading' (duration: 119.828984ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:12:29.779217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.384954ms","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-17T11:12:29.779264Z","caller":"traceutil/trace.go:171","msg":"trace[1725617082] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:11687; }","duration":"100.453075ms","start":"2026-10-17T11:12:29.678796Z","end":"2026-10-17T11:12:29.779249Z","steps":["trace[1725617082] 'agreement among raft nodes before linearized reading' (duration: 99.833183ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:15:04.167047Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10392} {"level":"info","ts":"2026-10-17T11:15:04.258002Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10392,"took":"88.292532ms","hash":903034529,"current-db-size-bytes":55689216,"current-db-size":"56 MB","current-db-size-in-use-bytes":27664384,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-17T11:15:04.258075Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":903034529,"revision":10392,"compact-revision":7992} {"level":"warn","ts":"2026-10-17T11:18:49.024515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.189064ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:18:49.024673Z","caller":"traceutil/trace.go:171","msg":"trace[2101189458] transaction","detail":"{read_only:false; response_revision:14236; number_of_response:1; }","duration":"191.344871ms","start":"2026-10-17T11:18:48.833303Z","end":"2026-10-17T11:18:49.024648Z","steps":["trace[2101189458] 'process raft request' (duration: 25.910702ms)","trace[2101189458] 'compare' (duration: 164.95904ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:18:58.127897Z","caller":"traceutil/trace.go:171","msg":"trace[76906012] linearizableReadLoop","detail":"{readStateIndex:14788; appliedIndex:14787; }","duration":"224.196303ms","start":"2026-10-17T11:18:57.903652Z","end":"2026-10-17T11:18:58.127848Z","steps":["trace[76906012] 'read index received' (duration: 223.935938ms)","trace[76906012] 'applied index is now lower than readState.Index' (duration: 259.315µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:18:58.127975Z","caller":"traceutil/trace.go:171","msg":"trace[36938849] transaction","detail":"{read_only:false; response_revision:14296; number_of_response:1; }","duration":"230.805356ms","start":"2026-10-17T11:18:57.89709Z","end":"2026-10-17T11:18:58.127895Z","steps":["trace[36938849] 'process raft request' (duration: 230.586822ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:18:58.128154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.476638ms","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-10-17T11:18:58.128211Z","caller":"traceutil/trace.go:171","msg":"trace[520188489] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14296; }","duration":"224.5722ms","start":"2026-10-17T11:18:57.903623Z","end":"2026-10-17T11:18:58.128195Z","steps":["trace[520188489] 'agreement among raft nodes before linearized reading' (duration: 224.386827ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:18:58.128305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.725599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-17T11:18:58.128452Z","caller":"traceutil/trace.go:171","msg":"trace[1158628603] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14296; }","duration":"219.909432ms","start":"2026-10-17T11:18:57.908519Z","end":"2026-10-17T11:18:58.128429Z","steps":["trace[1158628603] 'agreement among raft nodes before linearized reading' (duration: 219.617347ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:18:58.128558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.080939ms","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-10-17T11:18:58.128605Z","caller":"traceutil/trace.go:171","msg":"trace[1710507970] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:14296; }","duration":"181.168711ms","start":"2026-10-17T11:18:57.947422Z","end":"2026-10-17T11:18:58.128591Z","steps":["trace[1710507970] 'agreement among raft nodes before linearized reading' (duration: 181.055139ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:18:58.128453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.169759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nhmc7\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-10-17T11:18:58.128692Z","caller":"traceutil/trace.go:171","msg":"trace[311003682] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nhmc7; range_end:; response_count:1; response_revision:14296; }","duration":"169.426993ms","start":"2026-10-17T11:18:57.959227Z","end":"2026-10-17T11:18:58.128654Z","steps":["trace[311003682] 'agreement among raft nodes before linearized reading' (duration: 169.104818ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:18:58.289282Z","caller":"traceutil/trace.go:171","msg":"trace[1807229222] transaction","detail":"{read_only:false; response_revision:14297; number_of_response:1; }","duration":"156.437252ms","start":"2026-10-17T11:18:58.13282Z","end":"2026-10-17T11:18:58.289258Z","steps":["trace[1807229222] 'process raft request' (duration: 94.332005ms)","trace[1807229222] 'compare' (duration: 61.578306ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:18:58.289503Z","caller":"traceutil/trace.go:171","msg":"trace[1739507343] transaction","detail":"{read_only:false; response_revision:14299; number_of_response:1; }","duration":"156.123446ms","start":"2026-10-17T11:18:58.133344Z","end":"2026-10-17T11:18:58.289468Z","steps":["trace[1739507343] 'process raft request' (duration: 155.547525ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:18:58.289773Z","caller":"traceutil/trace.go:171","msg":"trace[1766237035] transaction","detail":"{read_only:false; response_revision:14298; number_of_response:1; }","duration":"156.459142ms","start":"2026-10-17T11:18:58.133302Z","end":"2026-10-17T11:18:58.289761Z","steps":["trace[1766237035] 'process raft request' (duration: 155.547126ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:19:21.240327Z","caller":"traceutil/trace.go:171","msg":"trace[1513236444] transaction","detail":"{read_only:false; response_revision:14612; number_of_response:1; }","duration":"248.519975ms","start":"2026-10-17T11:19:20.991774Z","end":"2026-10-17T11:19:21.240294Z","steps":["trace[1513236444] 'process raft request' (duration: 248.126597ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:20:04.175488Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12724} {"level":"info","ts":"2026-10-17T11:20:04.257563Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12724,"took":"79.391927ms","hash":1282840881,"current-db-size-bytes":55689216,"current-db-size":"56 MB","current-db-size-in-use-bytes":30801920,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T11:20:04.257635Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1282840881,"revision":12724,"compact-revision":10392} {"level":"warn","ts":"2026-10-17T11:20:47.702952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.853998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-rkcv7\" ","response":"range_response_count:1 size:22128"} {"level":"info","ts":"2026-10-17T11:20:47.703068Z","caller":"traceutil/trace.go:171","msg":"trace[172904249] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-rkcv7; range_end:; response_count:1; response_revision:15427; }","duration":"122.136394ms","start":"2026-10-17T11:20:47.580906Z","end":"2026-10-17T11:20:47.703042Z","steps":["trace[172904249] 'range keys from in-memory index tree' (duration: 121.640903ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:20:47.703101Z","caller":"traceutil/trace.go:171","msg":"trace[613966923] transaction","detail":"{read_only:false; response_revision:15428; number_of_response:1; }","duration":"102.458957ms","start":"2026-10-17T11:20:47.600622Z","end":"2026-10-17T11:20:47.703081Z","steps":["trace[613966923] 'process raft request' (duration: 88.933966ms)","trace[613966923] 'compare' (duration: 12.969541ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:20:47.859865Z","caller":"traceutil/trace.go:171","msg":"trace[109776940] transaction","detail":"{read_only:false; response_revision:15430; number_of_response:1; }","duration":"120.255508ms","start":"2026-10-17T11:20:47.739586Z","end":"2026-10-17T11:20:47.859842Z","steps":["trace[109776940] 'process raft request' (duration: 120.185087ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:20:47.859941Z","caller":"traceutil/trace.go:171","msg":"trace[392754690] linearizableReadLoop","detail":"{readStateIndex:15957; appliedIndex:15956; }","duration":"149.140656ms","start":"2026-10-17T11:20:47.710787Z","end":"2026-10-17T11:20:47.859928Z","steps":["trace[392754690] 'read index received' (duration: 98.370681ms)","trace[392754690] 'applied index is now lower than readState.Index' (duration: 50.768985ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:20:47.85987Z","caller":"traceutil/trace.go:171","msg":"trace[1112123315] transaction","detail":"{read_only:false; response_revision:15429; number_of_response:1; }","duration":"150.177066ms","start":"2026-10-17T11:20:47.709666Z","end":"2026-10-17T11:20:47.859843Z","steps":["trace[1112123315] 'process raft request' (duration: 99.495933ms)","trace[1112123315] 'compare' (duration: 50.434428ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:20:47.86034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.221184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-10-17T11:20:47.860433Z","caller":"traceutil/trace.go:171","msg":"trace[1051570605] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15430; }","duration":"101.345346ms","start":"2026-10-17T11:20:47.759066Z","end":"2026-10-17T11:20:47.860411Z","steps":["trace[1051570605] 'agreement among raft nodes before linearized reading' (duration: 101.149353ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:20:47.860497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.000235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-10-17T11:20:47.860593Z","caller":"traceutil/trace.go:171","msg":"trace[737712154] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15430; }","duration":"104.132388ms","start":"2026-10-17T11:20:47.75644Z","end":"2026-10-17T11:20:47.860572Z","steps":["trace[737712154] 'agreement among raft nodes before linearized reading' (duration: 103.869764ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:20:47.860835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.26519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:20:47.860864Z","caller":"traceutil/trace.go:171","msg":"trace[727106628] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15430; }","duration":"104.328892ms","start":"2026-10-17T11:20:47.756525Z","end":"2026-10-17T11:20:47.860854Z","steps":["trace[727106628] 'agreement among raft nodes before linearized reading' (duration: 104.275251ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:20:47.861004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.204015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:76 size:739964"} {"level":"info","ts":"2026-10-17T11:20:47.861072Z","caller":"traceutil/trace.go:171","msg":"trace[1445874461] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:76; response_revision:15430; }","duration":"150.275626ms","start":"2026-10-17T11:20:47.710779Z","end":"2026-10-17T11:20:47.861055Z","steps":["trace[1445874461] 'agreement among raft nodes before linearized reading' (duration: 149.231347ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:20:47.861123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.3288ms","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-17T11:20:47.861185Z","caller":"traceutil/trace.go:171","msg":"trace[1866066071] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15430; }","duration":"112.424072ms","start":"2026-10-17T11:20:47.748745Z","end":"2026-10-17T11:20:47.861169Z","steps":["trace[1866066071] 'agreement among raft nodes before linearized reading' (duration: 112.226169ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:20:47.86158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.91324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:76 size:739964"} {"level":"info","ts":"2026-10-17T11:20:47.861633Z","caller":"traceutil/trace.go:171","msg":"trace[1891078491] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:76; response_revision:15430; }","duration":"149.974022ms","start":"2026-10-17T11:20:47.711644Z","end":"2026-10-17T11:20:47.861618Z","steps":["trace[1891078491] 'agreement among raft nodes before linearized reading' (duration: 148.490083ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:20:49.000541Z","caller":"traceutil/trace.go:171","msg":"trace[764967603] transaction","detail":"{read_only:false; response_revision:15436; number_of_response:1; }","duration":"110.19858ms","start":"2026-10-17T11:20:48.890311Z","end":"2026-10-17T11:20:49.00051Z","steps":["trace[764967603] 'process raft request' (duration: 28.448969ms)","trace[764967603] 'compare' (duration: 81.613369ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:20:49.009571Z","caller":"traceutil/trace.go:171","msg":"trace[359342831] linearizableReadLoop","detail":"{readStateIndex:15965; appliedIndex:15963; }","duration":"113.310869ms","start":"2026-10-17T11:20:48.896242Z","end":"2026-10-17T11:20:49.009553Z","steps":["trace[359342831] 'read index received' (duration: 22.522949ms)","trace[359342831] 'applied index is now lower than readState.Index' (duration: 90.78682ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:20:49.009649Z","caller":"traceutil/trace.go:171","msg":"trace[2355802] transaction","detail":"{read_only:false; response_revision:15437; number_of_response:1; }","duration":"117.16949ms","start":"2026-10-17T11:20:48.892456Z","end":"2026-10-17T11:20:49.009626Z","steps":["trace[2355802] 'process raft request' (duration: 116.998577ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:20:49.010633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.364839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:76 size:739964"} {"level":"info","ts":"2026-10-17T11:20:49.010697Z","caller":"traceutil/trace.go:171","msg":"trace[1862435055] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:76; response_revision:15437; }","duration":"114.46367ms","start":"2026-10-17T11:20:48.896218Z","end":"2026-10-17T11:20:49.010682Z","steps":["trace[1862435055] 'agreement among raft nodes before linearized reading' (duration: 113.440871ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:25:04.183702Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15176} {"level":"info","ts":"2026-10-17T11:25:04.289451Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15176,"took":"102.733667ms","hash":3808135889,"current-db-size-bytes":55689216,"current-db-size":"56 MB","current-db-size-in-use-bytes":31551488,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T11:25:04.289524Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3808135889,"revision":15176,"compact-revision":12724} {"level":"info","ts":"2026-10-17T11:26:37.399678Z","caller":"traceutil/trace.go:171","msg":"trace[1622802962] transaction","detail":"{read_only:false; response_revision:18021; number_of_response:1; }","duration":"168.481133ms","start":"2026-10-17T11:26:37.231166Z","end":"2026-10-17T11:26:37.399647Z","steps":["trace[1622802962] 'process raft request' (duration: 138.039616ms)","trace[1622802962] 'compare' (duration: 30.01165ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:26:37.399861Z","caller":"traceutil/trace.go:171","msg":"trace[1140808799] transaction","detail":"{read_only:false; response_revision:18022; number_of_response:1; }","duration":"165.487817ms","start":"2026-10-17T11:26:37.234325Z","end":"2026-10-17T11:26:37.399813Z","steps":["trace[1140808799] 'process raft request' (duration: 165.207232ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:26:37.865452Z","caller":"traceutil/trace.go:171","msg":"trace[910946134] transaction","detail":"{read_only:false; response_revision:18024; number_of_response:1; }","duration":"221.111455ms","start":"2026-10-17T11:26:37.644306Z","end":"2026-10-17T11:26:37.865418Z","steps":["trace[910946134] 'process raft request' (duration: 220.905991ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:26:37.866514Z","caller":"traceutil/trace.go:171","msg":"trace[751507941] linearizableReadLoop","detail":"{readStateIndex:18637; appliedIndex:18637; }","duration":"189.939804ms","start":"2026-10-17T11:26:37.67656Z","end":"2026-10-17T11:26:37.8665Z","steps":["trace[751507941] 'read index received' (duration: 189.934364ms)","trace[751507941] 'applied index is now lower than readState.Index' (duration: 4.42µs)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:26:37.866824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.244819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-10-17T11:26:37.866808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.796951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-10-17T11:26:37.86687Z","caller":"traceutil/trace.go:171","msg":"trace[296629007] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18024; }","duration":"190.332481ms","start":"2026-10-17T11:26:37.676525Z","end":"2026-10-17T11:26:37.866857Z","steps":["trace[296629007] 'agreement among raft nodes before linearized reading' (duration: 190.179288ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:26:37.866888Z","caller":"traceutil/trace.go:171","msg":"trace[990266316] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18024; }","duration":"167.930282ms","start":"2026-10-17T11:26:37.698939Z","end":"2026-10-17T11:26:37.86687Z","steps":["trace[990266316] 'agreement among raft nodes before linearized reading' (duration: 167.681898ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:26:38.143175Z","caller":"traceutil/trace.go:171","msg":"trace[865650023] transaction","detail":"{read_only:false; response_revision:18025; number_of_response:1; }","duration":"272.162227ms","start":"2026-10-17T11:26:37.870995Z","end":"2026-10-17T11:26:38.143157Z","steps":["trace[865650023] 'process raft request' (duration: 272.047795ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:26:38.180197Z","caller":"traceutil/trace.go:171","msg":"trace[838975206] transaction","detail":"{read_only:false; response_revision:18026; number_of_response:1; }","duration":"308.477186ms","start":"2026-10-17T11:26:37.871696Z","end":"2026-10-17T11:26:38.180174Z","steps":["trace[838975206] 'process raft request' (duration: 308.370134ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:26:38.180319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:26:37.871675Z","time spent":"308.579217ms","remote":"127.0.0.1:33754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:29:05.962882Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"afeb1bf8b692f9e8","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T11:29:05.972529Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-17T11:29:05.972959Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-17T11:30:04.195915Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17390} {"level":"info","ts":"2026-10-17T11:30:04.300071Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17390,"took":"100.18722ms","hash":4287795241,"current-db-size-bytes":55689216,"current-db-size":"56 MB","current-db-size-in-use-bytes":34197504,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-17T11:30:04.300149Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4287795241,"revision":17390,"compact-revision":15176} {"level":"info","ts":"2026-10-17T11:32:12.520719Z","caller":"traceutil/trace.go:171","msg":"trace[1713501443] transaction","detail":"{read_only:false; response_revision:20643; number_of_response:1; }","duration":"161.081356ms","start":"2026-10-17T11:32:12.359605Z","end":"2026-10-17T11:32:12.520687Z","steps":["trace[1713501443] 'process raft request' (duration: 160.927503ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:32:18.27569Z","caller":"traceutil/trace.go:171","msg":"trace[1684921569] transaction","detail":"{read_only:false; response_revision:20674; number_of_response:1; }","duration":"225.040868ms","start":"2026-10-17T11:32:18.050608Z","end":"2026-10-17T11:32:18.275649Z","steps":["trace[1684921569] 'process raft request' (duration: 224.836164ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:32:18.485329Z","caller":"traceutil/trace.go:171","msg":"trace[573325077] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:20674; }","duration":"100.024246ms","start":"2026-10-17T11:32:18.385286Z","end":"2026-10-17T11:32:18.48531Z","steps":["trace[573325077] 'range keys from in-memory index tree' (duration: 99.848273ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:32:19.125468Z","caller":"traceutil/trace.go:171","msg":"trace[197492732] transaction","detail":"{read_only:false; response_revision:20677; number_of_response:1; }","duration":"384.591856ms","start":"2026-10-17T11:32:18.740814Z","end":"2026-10-17T11:32:19.125406Z","steps":["trace[197492732] 'process raft request' (duration: 349.216475ms)","trace[197492732] 'compare' (duration: 35.063444ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:32:19.125492Z","caller":"traceutil/trace.go:171","msg":"trace[1244727556] linearizableReadLoop","detail":"{readStateIndex:21378; appliedIndex:21374; }","duration":"371.614303ms","start":"2026-10-17T11:32:18.753853Z","end":"2026-10-17T11:32:19.125468Z","steps":["trace[1244727556] 'read index received' (duration: 75.929606ms)","trace[1244727556] 'applied index is now lower than readState.Index' (duration: 295.683797ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:32:19.125568Z","caller":"traceutil/trace.go:171","msg":"trace[1041326868] transaction","detail":"{read_only:false; response_revision:20678; number_of_response:1; }","duration":"383.205789ms","start":"2026-10-17T11:32:18.74233Z","end":"2026-10-17T11:32:19.125535Z","steps":["trace[1041326868] 'process raft request' (duration: 382.967885ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:32:19.12561Z","caller":"traceutil/trace.go:171","msg":"trace[932026192] transaction","detail":"{read_only:false; response_revision:20679; number_of_response:1; }","duration":"376.323091ms","start":"2026-10-17T11:32:18.749276Z","end":"2026-10-17T11:32:19.125599Z","steps":["trace[932026192] 'process raft request' (duration: 376.146908ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:32:19.125632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:32:18.740797Z","time spent":"384.751309ms","remote":"127.0.0.1:33754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:32:19.125723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:32:18.74926Z","time spent":"376.376122ms","remote":"127.0.0.1:33754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:32:19.125738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:32:18.742319Z","time spent":"383.312741ms","remote":"127.0.0.1:33754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:32:19.125821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.625604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-17T11:32:19.125884Z","caller":"traceutil/trace.go:171","msg":"trace[1627056373] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20679; }","duration":"371.726385ms","start":"2026-10-17T11:32:18.754139Z","end":"2026-10-17T11:32:19.125865Z","steps":["trace[1627056373] 'agreement among raft nodes before linearized reading' (duration: 371.525762ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:32:19.125918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:32:18.754117Z","time spent":"371.794437ms","remote":"127.0.0.1:33754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-17T11:32:19.126092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.205455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-10-17T11:32:19.126178Z","caller":"traceutil/trace.go:171","msg":"trace[1568396792] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20679; }","duration":"372.324877ms","start":"2026-10-17T11:32:18.753829Z","end":"2026-10-17T11:32:19.126154Z","steps":["trace[1568396792] 'agreement among raft nodes before linearized reading' (duration: 372.013551ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:32:19.126155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.559541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"warn","ts":"2026-10-17T11:32:19.126228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:32:18.753818Z","time spent":"372.396698ms","remote":"127.0.0.1:33754","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":"info","ts":"2026-10-17T11:32:19.126386Z","caller":"traceutil/trace.go:171","msg":"trace[1454791897] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:20679; }","duration":"364.729555ms","start":"2026-10-17T11:32:18.76154Z","end":"2026-10-17T11:32:19.126269Z","steps":["trace[1454791897] 'agreement among raft nodes before linearized reading' (duration: 364.308467ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:32:19.126489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:32:18.761527Z","time spent":"364.901718ms","remote":"127.0.0.1:33754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-10-17T11:35:04.206992Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19761} {"level":"info","ts":"2026-10-17T11:35:04.329292Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19761,"took":"118.658732ms","hash":3561197857,"current-db-size-bytes":55689216,"current-db-size":"56 MB","current-db-size-in-use-bytes":30171136,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-17T11:35:04.329398Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3561197857,"revision":19761,"compact-revision":17390} {"level":"info","ts":"2026-10-17T11:36:12.728447Z","caller":"traceutil/trace.go:171","msg":"trace[501659694] transaction","detail":"{read_only:false; response_revision:23141; number_of_response:1; }","duration":"273.896656ms","start":"2026-10-17T11:36:12.454509Z","end":"2026-10-17T11:36:12.728405Z","steps":["trace[501659694] 'process raft request' (duration: 273.690492ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:36:12.729691Z","caller":"traceutil/trace.go:171","msg":"trace[811156323] transaction","detail":"{read_only:false; response_revision:23142; number_of_response:1; }","duration":"274.549189ms","start":"2026-10-17T11:36:12.455096Z","end":"2026-10-17T11:36:12.729645Z","steps":["trace[811156323] 'process raft request' (duration: 274.228973ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:36:12.731723Z","caller":"traceutil/trace.go:171","msg":"trace[1771120697] linearizableReadLoop","detail":"{readStateIndex:23914; appliedIndex:23913; }","duration":"248.91174ms","start":"2026-10-17T11:36:12.482779Z","end":"2026-10-17T11:36:12.73169Z","steps":["trace[1771120697] 'read index received' (duration: 245.67545ms)","trace[1771120697] 'applied index is now lower than readState.Index' (duration: 3.23469ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:36:12.731899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.101474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-10-17T11:36:12.732011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.340184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-10-17T11:36:12.732072Z","caller":"traceutil/trace.go:171","msg":"trace[810187558] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:23142; }","duration":"245.467457ms","start":"2026-10-17T11:36:12.486586Z","end":"2026-10-17T11:36:12.732053Z","steps":["trace[810187558] 'agreement among raft nodes before linearized reading' (duration: 245.272323ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:36:12.732036Z","caller":"traceutil/trace.go:171","msg":"trace[1470052820] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:23142; }","duration":"249.318718ms","start":"2026-10-17T11:36:12.482699Z","end":"2026-10-17T11:36:12.732018Z","steps":["trace[1470052820] 'agreement among raft nodes before linearized reading' (duration: 249.092164ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:39:39.032109Z","caller":"traceutil/trace.go:171","msg":"trace[1167634633] transaction","detail":"{read_only:false; response_revision:25147; number_of_response:1; }","duration":"195.133078ms","start":"2026-10-17T11:39:38.836952Z","end":"2026-10-17T11:39:39.032085Z","steps":["trace[1167634633] 'process raft request' (duration: 194.932435ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:39:39.032437Z","caller":"traceutil/trace.go:171","msg":"trace[317281689] transaction","detail":"{read_only:false; response_revision:25149; number_of_response:1; }","duration":"186.287053ms","start":"2026-10-17T11:39:38.846125Z","end":"2026-10-17T11:39:39.032412Z","steps":["trace[317281689] 'process raft request' (duration: 186.144501ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:39:39.032456Z","caller":"traceutil/trace.go:171","msg":"trace[2082739908] transaction","detail":"{read_only:false; response_revision:25148; number_of_response:1; }","duration":"189.610225ms","start":"2026-10-17T11:39:38.842824Z","end":"2026-10-17T11:39:39.032434Z","steps":["trace[2082739908] 'process raft request' (duration: 189.210757ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:39:39.288015Z","caller":"traceutil/trace.go:171","msg":"trace[1069267376] linearizableReadLoop","detail":"{readStateIndex:25972; appliedIndex:25971; }","duration":"114.606527ms","start":"2026-10-17T11:39:39.173385Z","end":"2026-10-17T11:39:39.287992Z","steps":["trace[1069267376] 'read index received' (duration: 114.404893ms)","trace[1069267376] 'applied index is now lower than readState.Index' (duration: 200.734µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:39:39.288088Z","caller":"traceutil/trace.go:171","msg":"trace[1711086555] transaction","detail":"{read_only:false; response_revision:25150; number_of_response:1; }","duration":"116.615295ms","start":"2026-10-17T11:39:39.171434Z","end":"2026-10-17T11:39:39.288049Z","steps":["trace[1711086555] 'process raft request' (duration: 116.408601ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:39:39.288912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.31981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackservers/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackservers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T11:39:39.288957Z","caller":"traceutil/trace.go:171","msg":"trace[1711849120] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackservers/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackservers0; response_count:0; response_revision:25150; }","duration":"115.622765ms","start":"2026-10-17T11:39:39.173319Z","end":"2026-10-17T11:39:39.288942Z","steps":["trace[1711849120] 'agreement among raft nodes before linearized reading' (duration: 114.80125ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:39:39.608676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.486659ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T11:39:39.608832Z","caller":"traceutil/trace.go:171","msg":"trace[512250099] transaction","detail":"{read_only:false; response_revision:25151; number_of_response:1; }","duration":"316.185925ms","start":"2026-10-17T11:39:39.292619Z","end":"2026-10-17T11:39:39.608805Z","steps":["trace[512250099] 'process raft request' (duration: 152.474592ms)","trace[512250099] 'compare' (duration: 163.208533ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:39:39.608919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:39:39.292605Z","time spent":"316.269366ms","remote":"127.0.0.1:33754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:39:39.894549Z","caller":"traceutil/trace.go:171","msg":"trace[480192606] transaction","detail":"{read_only:false; response_revision:25152; number_of_response:1; }","duration":"161.358628ms","start":"2026-10-17T11:39:39.73316Z","end":"2026-10-17T11:39:39.894518Z","steps":["trace[480192606] 'process raft request' (duration: 67.62445ms)","trace[480192606] 'compare' (duration: 93.429652ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:40:04.21339Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21977} {"level":"info","ts":"2026-10-17T11:40:04.326933Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21977,"took":"109.335379ms","hash":184505634,"current-db-size-bytes":57815040,"current-db-size":"58 MB","current-db-size-in-use-bytes":44969984,"current-db-size-in-use":"45 MB"} {"level":"info","ts":"2026-10-17T11:40:04.327002Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":184505634,"revision":21977,"compact-revision":19761} {"level":"info","ts":"2026-10-17T11:40:17.20294Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006712.wal"} {"level":"info","ts":"2026-10-17T11:40:39.503164Z","caller":"traceutil/trace.go:171","msg":"trace[97641167] transaction","detail":"{read_only:false; response_revision:25725; number_of_response:1; }","duration":"202.579156ms","start":"2026-10-17T11:40:39.300555Z","end":"2026-10-17T11:40:39.503134Z","steps":["trace[97641167] 'process raft request' (duration: 202.354512ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:40:39.503433Z","caller":"traceutil/trace.go:171","msg":"trace[1450015297] transaction","detail":"{read_only:false; response_revision:25726; number_of_response:1; }","duration":"196.015004ms","start":"2026-10-17T11:40:39.307387Z","end":"2026-10-17T11:40:39.503402Z","steps":["trace[1450015297] 'process raft request' (duration: 195.692068ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:39.851077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.156843ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T11:40:39.851187Z","caller":"traceutil/trace.go:171","msg":"trace[1044863777] transaction","detail":"{read_only:false; response_revision:25727; number_of_response:1; }","duration":"330.633514ms","start":"2026-10-17T11:40:39.520535Z","end":"2026-10-17T11:40:39.851168Z","steps":["trace[1044863777] 'process raft request' (duration: 146.299217ms)","trace[1044863777] 'compare' (duration: 183.450451ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:40:39.851246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:40:39.520496Z","time spent":"330.717396ms","remote":"127.0.0.1:33754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:40:40.160304Z","caller":"traceutil/trace.go:171","msg":"trace[1519643434] transaction","detail":"{read_only:false; response_revision:25728; number_of_response:1; }","duration":"108.522483ms","start":"2026-10-17T11:40:40.051761Z","end":"2026-10-17T11:40:40.160284Z","steps":["trace[1519643434] 'process raft request' (duration: 108.199747ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:40:40.393551Z","caller":"traceutil/trace.go:171","msg":"trace[221274161] transaction","detail":"{read_only:false; response_revision:25729; number_of_response:1; }","duration":"278.538923ms","start":"2026-10-17T11:40:40.114993Z","end":"2026-10-17T11:40:40.393532Z","steps":["trace[221274161] 'process raft request' (duration: 278.33634ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:40:40.393734Z","caller":"traceutil/trace.go:171","msg":"trace[692762072] linearizableReadLoop","detail":"{readStateIndex:26566; appliedIndex:26564; }","duration":"230.65561ms","start":"2026-10-17T11:40:40.163061Z","end":"2026-10-17T11:40:40.393717Z","steps":["trace[692762072] 'read index received' (duration: 230.239872ms)","trace[692762072] 'applied index is now lower than readState.Index' (duration: 414.968µs)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:40:40.393912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.239677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T11:40:40.393957Z","caller":"traceutil/trace.go:171","msg":"trace[728137071] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25730; }","duration":"197.316418ms","start":"2026-10-17T11:40:40.196627Z","end":"2026-10-17T11:40:40.393944Z","steps":["trace[728137071] 'agreement among raft nodes before linearized reading' (duration: 197.243247ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:40:40.393983Z","caller":"traceutil/trace.go:171","msg":"trace[1591525842] transaction","detail":"{read_only:false; response_revision:25730; number_of_response:1; }","duration":"264.713044ms","start":"2026-10-17T11:40:40.129258Z","end":"2026-10-17T11:40:40.393971Z","steps":["trace[1591525842] 'process raft request' (duration: 264.231486ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:40.394119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.948819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-10-17T11:40:40.394142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.074257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-295db4e1-b27f-4856-abe6-75f4fcad5a4a\" ","response":"range_response_count:1 size:1294"} {"level":"info","ts":"2026-10-17T11:40:40.394199Z","caller":"traceutil/trace.go:171","msg":"trace[476063675] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25730; }","duration":"155.094841ms","start":"2026-10-17T11:40:40.239085Z","end":"2026-10-17T11:40:40.39418Z","steps":["trace[476063675] 'agreement among raft nodes before linearized reading' (duration: 154.865597ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:40:40.394213Z","caller":"traceutil/trace.go:171","msg":"trace[1510799928] range","detail":"{range_begin:/registry/persistentvolumes/pvc-295db4e1-b27f-4856-abe6-75f4fcad5a4a; range_end:; response_count:1; response_revision:25730; }","duration":"231.181559ms","start":"2026-10-17T11:40:40.16301Z","end":"2026-10-17T11:40:40.394192Z","steps":["trace[1510799928] 'agreement among raft nodes before linearized reading' (duration: 230.994816ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:40.394275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.013278ms","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-10-17T11:40:40.394399Z","caller":"traceutil/trace.go:171","msg":"trace[15366149] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25730; }","duration":"157.16452ms","start":"2026-10-17T11:40:40.237217Z","end":"2026-10-17T11:40:40.394381Z","steps":["trace[15366149] 'agreement among raft nodes before linearized reading' (duration: 156.875445ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:45:04.232077Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25441} {"level":"info","ts":"2026-10-17T11:45:04.425627Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25441,"took":"188.920021ms","hash":3585496478,"current-db-size-bytes":59514880,"current-db-size":"60 MB","current-db-size-in-use-bytes":35893248,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-17T11:45:04.425762Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3585496478,"revision":25441,"compact-revision":21977} {"level":"info","ts":"2026-10-17T11:46:45.921714Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"afeb1bf8b692f9e8","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T11:46:45.929176Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-17T11:46:45.929303Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-17T11:50:04.244295Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28318} {"level":"info","ts":"2026-10-17T11:50:04.394044Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28318,"took":"145.854338ms","hash":135735492,"current-db-size-bytes":59514880,"current-db-size":"60 MB","current-db-size-in-use-bytes":30863360,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T11:50:04.394125Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":135735492,"revision":28318,"compact-revision":25441} {"level":"info","ts":"2026-10-17T11:55:04.251511Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30544} {"level":"info","ts":"2026-10-17T11:55:04.372983Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30544,"took":"117.679723ms","hash":827965674,"current-db-size-bytes":59514880,"current-db-size":"60 MB","current-db-size-in-use-bytes":31145984,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T11:55:04.37306Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":827965674,"revision":30544,"compact-revision":28318} {"level":"info","ts":"2026-10-17T12:00:04.26543Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32797} {"level":"info","ts":"2026-10-17T12:00:04.409915Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32797,"took":"141.374104ms","hash":2490051187,"current-db-size-bytes":59514880,"current-db-size":"60 MB","current-db-size-in-use-bytes":31244288,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T12:00:04.409959Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2490051187,"revision":32797,"compact-revision":30544} {"level":"info","ts":"2026-10-17T12:05:04.271687Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35142} {"level":"info","ts":"2026-10-17T12:05:04.402394Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35142,"took":"127.273282ms","hash":1220916862,"current-db-size-bytes":59514880,"current-db-size":"60 MB","current-db-size-in-use-bytes":33013760,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-17T12:05:04.402453Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1220916862,"revision":35142,"compact-revision":32797} {"level":"info","ts":"2026-10-17T12:08:01.124213Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"afeb1bf8b692f9e8","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T12:08:01.130855Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-17T12:08:01.131129Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-17T12:10:04.286109Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37432} {"level":"info","ts":"2026-10-17T12:10:04.456627Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37432,"took":"165.862847ms","hash":4133517679,"current-db-size-bytes":60362752,"current-db-size":"60 MB","current-db-size-in-use-bytes":32968704,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-17T12:10:04.456806Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4133517679,"revision":37432,"compact-revision":35142}