{"level":"warn","ts":"2026-04-17T18:44:58.277056Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-17T18:44:58.277123Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.237:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.237:2380","--initial-cluster=instance=https://199.19.213.237:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.237:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.237: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-04-17T18:44:58.277184Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-17T18:44:58.277228Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.237:2380"]} {"level":"info","ts":"2026-04-17T18:44:58.277256Z","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-04-17T18:44:58.278138Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.237:2379"]} {"level":"info","ts":"2026-04-17T18:44:58.278266Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.237:2380"],"listen-peer-urls":["https://199.19.213.237:2380"],"advertise-client-urls":["https://199.19.213.237:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.237:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.237: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-04-17T18:44:58.282414Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.810829ms"} {"level":"info","ts":"2026-04-17T18:44:58.288642Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c51d7a9ea5537d6e","cluster-id":"bea7a5ea8f053dc3"} {"level":"info","ts":"2026-04-17T18:44:58.288709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e switched to configuration voters=()"} {"level":"info","ts":"2026-04-17T18:44:58.28873Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e became follower at term 0"} {"level":"info","ts":"2026-04-17T18:44:58.288775Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c51d7a9ea5537d6e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-17T18:44:58.288788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e became follower at term 1"} {"level":"info","ts":"2026-04-17T18:44:58.288847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e switched to configuration voters=(14203643621593546094)"} {"level":"warn","ts":"2026-04-17T18:44:58.293878Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-17T18:44:58.296045Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-17T18:44:58.297286Z","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-04-17T18:44:58.299631Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c51d7a9ea5537d6e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-17T18:44:58.299844Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c51d7a9ea5537d6e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-17T18:44:58.29991Z","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-04-17T18:44:58.300114Z","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-04-17T18:44:58.300197Z","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-04-17T18:44:58.300516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e switched to configuration voters=(14203643621593546094)"} {"level":"info","ts":"2026-04-17T18:44:58.300743Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"bea7a5ea8f053dc3","local-member-id":"c51d7a9ea5537d6e","added-peer-id":"c51d7a9ea5537d6e","added-peer-peer-urls":["https://199.19.213.237:2380"]} {"level":"info","ts":"2026-04-17T18:44:58.303341Z","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-04-17T18:44:58.303389Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.237:2380"} {"level":"info","ts":"2026-04-17T18:44:58.303443Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.237:2380"} {"level":"info","ts":"2026-04-17T18:44:58.303777Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c51d7a9ea5537d6e","initial-advertise-peer-urls":["https://199.19.213.237:2380"],"listen-peer-urls":["https://199.19.213.237:2380"],"advertise-client-urls":["https://199.19.213.237:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.237:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-17T18:44:58.303831Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-17T18:44:59.190113Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e is starting a new election at term 1"} {"level":"info","ts":"2026-04-17T18:44:59.190187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e became pre-candidate at term 1"} {"level":"info","ts":"2026-04-17T18:44:59.190229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e received MsgPreVoteResp from c51d7a9ea5537d6e at term 1"} {"level":"info","ts":"2026-04-17T18:44:59.190249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e became candidate at term 2"} {"level":"info","ts":"2026-04-17T18:44:59.190262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e received MsgVoteResp from c51d7a9ea5537d6e at term 2"} {"level":"info","ts":"2026-04-17T18:44:59.190278Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c51d7a9ea5537d6e became leader at term 2"} {"level":"info","ts":"2026-04-17T18:44:59.190299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c51d7a9ea5537d6e elected leader c51d7a9ea5537d6e at term 2"} {"level":"info","ts":"2026-04-17T18:44:59.191339Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T18:44:59.192002Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T18:44:59.19207Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T18:44:59.191997Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c51d7a9ea5537d6e","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.237:2379]}","request-path":"/0/members/c51d7a9ea5537d6e/attributes","cluster-id":"bea7a5ea8f053dc3","publish-timeout":"7s"} {"level":"info","ts":"2026-04-17T18:44:59.192383Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"bea7a5ea8f053dc3","local-member-id":"c51d7a9ea5537d6e","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T18:44:59.192481Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T18:44:59.192462Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-17T18:44:59.192517Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T18:44:59.192543Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-17T18:44:59.195216Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-17T18:44:59.196146Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.237:2379"} {"level":"info","ts":"2026-04-17T18:45:08.930353Z","caller":"traceutil/trace.go:171","msg":"trace[115924781] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"133.702144ms","start":"2026-04-17T18:45:08.796623Z","end":"2026-04-17T18:45:08.930325Z","steps":["trace[115924781] 'process raft request' (duration: 133.511698ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:45:09.392994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.656731ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-17T18:45:09.393144Z","caller":"traceutil/trace.go:171","msg":"trace[673556104] linearizableReadLoop","detail":"{readStateIndex:321; appliedIndex:320; }","duration":"454.757835ms","start":"2026-04-17T18:45:08.938367Z","end":"2026-04-17T18:45:09.393125Z","steps":["trace[673556104] 'read index received' (duration: 208.391037ms)","trace[673556104] 'applied index is now lower than readState.Index' (duration: 246.365238ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:45:09.393182Z","caller":"traceutil/trace.go:171","msg":"trace[1592315049] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"454.808727ms","start":"2026-04-17T18:45:08.938335Z","end":"2026-04-17T18:45:09.393144Z","steps":["trace[1592315049] 'process raft request' (duration: 208.419168ms)","trace[1592315049] 'compare' (duration: 245.489757ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:45:09.393266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.885938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-04-17T18:45:09.393311Z","caller":"traceutil/trace.go:171","msg":"trace[957297262] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:311; }","duration":"454.936449ms","start":"2026-04-17T18:45:08.938362Z","end":"2026-04-17T18:45:09.393298Z","steps":["trace[957297262] 'agreement among raft nodes before linearized reading' (duration: 454.833297ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:45:09.393322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:45:08.938318Z","time spent":"454.936329ms","remote":"127.0.0.1:58408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":156,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T18:45:09.393373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:45:08.938321Z","time spent":"455.040712ms","remote":"127.0.0.1:58408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":227,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"info","ts":"2026-04-17T18:45:09.567649Z","caller":"traceutil/trace.go:171","msg":"trace[1571994337] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"628.336103ms","start":"2026-04-17T18:45:08.939277Z","end":"2026-04-17T18:45:09.567613Z","steps":["trace[1571994337] 'process raft request' (duration: 567.07349ms)","trace[1571994337] 'compare' (duration: 61.011917ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:45:09.567716Z","caller":"traceutil/trace.go:171","msg":"trace[1041613501] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"627.531424ms","start":"2026-04-17T18:45:08.940161Z","end":"2026-04-17T18:45:09.567692Z","steps":["trace[1041613501] 'process raft request' (duration: 627.33713ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:45:09.567795Z","caller":"traceutil/trace.go:171","msg":"trace[644815088] linearizableReadLoop","detail":"{readStateIndex:323; appliedIndex:321; }","duration":"174.596862ms","start":"2026-04-17T18:45:09.393171Z","end":"2026-04-17T18:45:09.567768Z","steps":["trace[644815088] 'read index received' (duration: 113.153986ms)","trace[644815088] 'applied index is now lower than readState.Index' (duration: 61.440736ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:45:09.567879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:45:08.940146Z","time spent":"627.647757ms","remote":"127.0.0.1:58682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3642,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T18:45:09.567946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.424793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-04-17T18:45:09.567954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.251453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-17T18:45:09.567939Z","caller":"traceutil/trace.go:171","msg":"trace[107363827] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"166.901973ms","start":"2026-04-17T18:45:09.40096Z","end":"2026-04-17T18:45:09.567862Z","steps":["trace[107363827] 'process raft request' (duration: 166.810411ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:45:09.56797Z","caller":"traceutil/trace.go:171","msg":"trace[1341042999] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"170.906827ms","start":"2026-04-17T18:45:09.397009Z","end":"2026-04-17T18:45:09.567916Z","steps":["trace[1341042999] 'process raft request' (duration: 170.687952ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:45:09.568034Z","caller":"traceutil/trace.go:171","msg":"trace[1481569289] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:315; }","duration":"479.373736ms","start":"2026-04-17T18:45:09.088638Z","end":"2026-04-17T18:45:09.568012Z","steps":["trace[1481569289] 'agreement among raft nodes before linearized reading' (duration: 479.201782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:45:09.568051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.70393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-04-17T18:45:09.568081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:45:09.088614Z","time spent":"479.454937ms","remote":"127.0.0.1:58408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":233,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "} {"level":"info","ts":"2026-04-17T18:45:09.568096Z","caller":"traceutil/trace.go:171","msg":"trace[357913363] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:315; }","duration":"528.780882ms","start":"2026-04-17T18:45:09.039307Z","end":"2026-04-17T18:45:09.568088Z","steps":["trace[357913363] 'agreement among raft nodes before linearized reading' (duration: 528.715951ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:45:09.568066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.72453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"warn","ts":"2026-04-17T18:45:09.568092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:45:08.939261Z","time spent":"628.467915ms","remote":"127.0.0.1:58466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T18:45:09.568144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:45:09.039286Z","time spent":"528.849134ms","remote":"127.0.0.1:58408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"info","ts":"2026-04-17T18:45:09.567989Z","caller":"traceutil/trace.go:171","msg":"trace[1639438448] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:315; }","duration":"578.542926ms","start":"2026-04-17T18:45:08.989435Z","end":"2026-04-17T18:45:09.567978Z","steps":["trace[1639438448] 'agreement among raft nodes before linearized reading' (duration: 578.438914ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:45:09.568172Z","caller":"traceutil/trace.go:171","msg":"trace[1905758875] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:315; }","duration":"428.860793ms","start":"2026-04-17T18:45:09.139284Z","end":"2026-04-17T18:45:09.568144Z","steps":["trace[1905758875] 'agreement among raft nodes before linearized reading' (duration: 428.587577ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:45:09.568225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:45:09.139265Z","time spent":"428.951225ms","remote":"127.0.0.1:58408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":221,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "} {"level":"warn","ts":"2026-04-17T18:45:09.568261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:45:08.98941Z","time spent":"578.777312ms","remote":"127.0.0.1:58408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "} {"level":"info","ts":"2026-04-17T18:45:29.426384Z","caller":"traceutil/trace.go:171","msg":"trace[1526782633] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"105.452457ms","start":"2026-04-17T18:45:29.3209Z","end":"2026-04-17T18:45:29.426353Z","steps":["trace[1526782633] 'process raft request' (duration: 13.35565ms)","trace[1526782633] 'compare' (duration: 91.976895ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:45:29.433065Z","caller":"traceutil/trace.go:171","msg":"trace[32333686] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"104.058375ms","start":"2026-04-17T18:45:29.328972Z","end":"2026-04-17T18:45:29.43303Z","steps":["trace[32333686] 'process raft request' (duration: 103.86493ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:45:29.433323Z","caller":"traceutil/trace.go:171","msg":"trace[24313705] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"109.8856ms","start":"2026-04-17T18:45:29.323422Z","end":"2026-04-17T18:45:29.433307Z","steps":["trace[24313705] 'process raft request' (duration: 104.052705ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:45:29.43345Z","caller":"traceutil/trace.go:171","msg":"trace[1907207251] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"110.884553ms","start":"2026-04-17T18:45:29.32255Z","end":"2026-04-17T18:45:29.433435Z","steps":["trace[1907207251] 'process raft request' (duration: 104.675169ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:45:29.433686Z","caller":"traceutil/trace.go:171","msg":"trace[1101082837] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"111.038697ms","start":"2026-04-17T18:45:29.322619Z","end":"2026-04-17T18:45:29.433658Z","steps":["trace[1101082837] 'process raft request' (duration: 104.761601ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:45:35.246171Z","caller":"traceutil/trace.go:171","msg":"trace[623179126] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"133.643871ms","start":"2026-04-17T18:45:35.112471Z","end":"2026-04-17T18:45:35.246115Z","steps":["trace[623179126] 'process raft request' (duration: 133.009837ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:45:35.636776Z","caller":"traceutil/trace.go:171","msg":"trace[1812823216] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:599; }","duration":"299.955512ms","start":"2026-04-17T18:45:35.336789Z","end":"2026-04-17T18:45:35.636744Z","steps":["trace[1812823216] 'read index received' (duration: 299.678816ms)","trace[1812823216] 'applied index is now lower than readState.Index' (duration: 275.276µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:45:35.636949Z","caller":"traceutil/trace.go:171","msg":"trace[1619724407] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"332.15897ms","start":"2026-04-17T18:45:35.304749Z","end":"2026-04-17T18:45:35.636908Z","steps":["trace[1619724407] 'process raft request' (duration: 331.823712ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:45:35.637048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.239889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5wmrd\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-17T18:45:35.637086Z","caller":"traceutil/trace.go:171","msg":"trace[174056602] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5wmrd; range_end:; response_count:1; response_revision:577; }","duration":"300.326781ms","start":"2026-04-17T18:45:35.336748Z","end":"2026-04-17T18:45:35.637075Z","steps":["trace[174056602] 'agreement among raft nodes before linearized reading' (duration: 300.100476ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:45:35.637121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:45:35.30472Z","time spent":"332.322123ms","remote":"127.0.0.1:58698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T18:45:35.63713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:45:35.336729Z","time spent":"300.392782ms","remote":"127.0.0.1:58400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-5wmrd\" "} {"level":"info","ts":"2026-04-17T18:45:36.04426Z","caller":"traceutil/trace.go:171","msg":"trace[1820992320] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:602; }","duration":"181.207615ms","start":"2026-04-17T18:45:35.863007Z","end":"2026-04-17T18:45:36.044214Z","steps":["trace[1820992320] 'read index received' (duration: 180.95611ms)","trace[1820992320] 'applied index is now lower than readState.Index' (duration: 249.255µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:45:36.044342Z","caller":"traceutil/trace.go:171","msg":"trace[1568307532] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"199.05768ms","start":"2026-04-17T18:45:35.845257Z","end":"2026-04-17T18:45:36.044315Z","steps":["trace[1568307532] 'process raft request' (duration: 198.680681ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:45:36.044514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.497852ms","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-04-17T18:45:36.044603Z","caller":"traceutil/trace.go:171","msg":"trace[1237673153] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:580; }","duration":"181.581144ms","start":"2026-04-17T18:45:35.862963Z","end":"2026-04-17T18:45:36.044545Z","steps":["trace[1237673153] 'agreement among raft nodes before linearized reading' (duration: 181.436181ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:45:36.242106Z","caller":"traceutil/trace.go:171","msg":"trace[2023841983] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:603; }","duration":"195.520058ms","start":"2026-04-17T18:45:36.046559Z","end":"2026-04-17T18:45:36.242079Z","steps":["trace[2023841983] 'read index received' (duration: 194.828672ms)","trace[2023841983] 'applied index is now lower than readState.Index' (duration: 690.216µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:45:36.242218Z","caller":"traceutil/trace.go:171","msg":"trace[607248921] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"206.549734ms","start":"2026-04-17T18:45:36.035626Z","end":"2026-04-17T18:45:36.242176Z","steps":["trace[607248921] 'process raft request' (duration: 205.92304ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:45:36.242332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.763013ms","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-04-17T18:45:36.242391Z","caller":"traceutil/trace.go:171","msg":"trace[761252720] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:581; }","duration":"195.861105ms","start":"2026-04-17T18:45:36.046504Z","end":"2026-04-17T18:45:36.242366Z","steps":["trace[761252720] 'agreement among raft nodes before linearized reading' (duration: 195.704022ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:45:36.243443Z","caller":"traceutil/trace.go:171","msg":"trace[1981763183] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"194.522914ms","start":"2026-04-17T18:45:36.048896Z","end":"2026-04-17T18:45:36.243419Z","steps":["trace[1981763183] 'process raft request' (duration: 194.114455ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:46:41.863759Z","caller":"traceutil/trace.go:171","msg":"trace[1976772241] transaction","detail":"{read_only:false; response_revision:1398; number_of_response:1; }","duration":"121.36559ms","start":"2026-04-17T18:46:41.742369Z","end":"2026-04-17T18:46:41.863734Z","steps":["trace[1976772241] 'process raft request' (duration: 121.196347ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:47:05.293068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.198744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:659"} {"level":"info","ts":"2026-04-17T18:47:05.293152Z","caller":"traceutil/trace.go:171","msg":"trace[1719058019] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1790; }","duration":"150.342017ms","start":"2026-04-17T18:47:05.142789Z","end":"2026-04-17T18:47:05.293131Z","steps":["trace[1719058019] 'range keys from in-memory index tree' (duration: 149.9928ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:47:05.429641Z","caller":"traceutil/trace.go:171","msg":"trace[1682272955] transaction","detail":"{read_only:false; response_revision:1792; number_of_response:1; }","duration":"106.668186ms","start":"2026-04-17T18:47:05.322937Z","end":"2026-04-17T18:47:05.429605Z","steps":["trace[1682272955] 'process raft request' (duration: 75.415279ms)","trace[1682272955] 'compare' (duration: 31.065033ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:47:48.348143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.275179ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T18:47:48.348321Z","caller":"traceutil/trace.go:171","msg":"trace[1554853260] linearizableReadLoop","detail":"{readStateIndex:2205; appliedIndex:2204; }","duration":"151.411485ms","start":"2026-04-17T18:47:48.196888Z","end":"2026-04-17T18:47:48.348299Z","steps":["trace[1554853260] 'read index received' (duration: 46.87717ms)","trace[1554853260] 'applied index is now lower than readState.Index' (duration: 104.532085ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:47:48.348461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.565949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T18:47:48.348444Z","caller":"traceutil/trace.go:171","msg":"trace[561141265] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"168.838142ms","start":"2026-04-17T18:47:48.179567Z","end":"2026-04-17T18:47:48.348406Z","steps":["trace[561141265] 'process raft request' (duration: 64.137063ms)","trace[561141265] 'compare' (duration: 104.071184ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:47:48.348521Z","caller":"traceutil/trace.go:171","msg":"trace[2130529529] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2134; }","duration":"151.661271ms","start":"2026-04-17T18:47:48.196848Z","end":"2026-04-17T18:47:48.34851Z","steps":["trace[2130529529] 'agreement among raft nodes before linearized reading' (duration: 151.569979ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:47:48.349112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.691455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-17T18:47:48.349365Z","caller":"traceutil/trace.go:171","msg":"trace[355641583] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2134; }","duration":"129.006962ms","start":"2026-04-17T18:47:48.22034Z","end":"2026-04-17T18:47:48.349347Z","steps":["trace[355641583] 'agreement among raft nodes before linearized reading' (duration: 128.418649ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:47:48.931567Z","caller":"traceutil/trace.go:171","msg":"trace[1927797013] linearizableReadLoop","detail":"{readStateIndex:2208; appliedIndex:2207; }","duration":"206.630247ms","start":"2026-04-17T18:47:48.724906Z","end":"2026-04-17T18:47:48.931536Z","steps":["trace[1927797013] 'read index received' (duration: 206.446433ms)","trace[1927797013] 'applied index is now lower than readState.Index' (duration: 182.324µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:47:48.931596Z","caller":"traceutil/trace.go:171","msg":"trace[284669026] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"234.771393ms","start":"2026-04-17T18:47:48.696796Z","end":"2026-04-17T18:47:48.931568Z","steps":["trace[284669026] 'process raft request' (duration: 234.561569ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:47:48.931766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.844281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"} {"level":"info","ts":"2026-04-17T18:47:48.931806Z","caller":"traceutil/trace.go:171","msg":"trace[1407095227] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2137; }","duration":"206.897182ms","start":"2026-04-17T18:47:48.724898Z","end":"2026-04-17T18:47:48.931795Z","steps":["trace[1407095227] 'agreement among raft nodes before linearized reading' (duration: 206.748709ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:48:55.610642Z","caller":"traceutil/trace.go:171","msg":"trace[1798070773] transaction","detail":"{read_only:false; response_revision:2651; number_of_response:1; }","duration":"144.640452ms","start":"2026-04-17T18:48:55.465972Z","end":"2026-04-17T18:48:55.610612Z","steps":["trace[1798070773] 'process raft request' (duration: 144.261684ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:49:00.971897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.978198ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T18:49:00.971997Z","caller":"traceutil/trace.go:171","msg":"trace[73974210] transaction","detail":"{read_only:false; response_revision:2683; number_of_response:1; }","duration":"267.939504ms","start":"2026-04-17T18:49:00.70404Z","end":"2026-04-17T18:49:00.971979Z","steps":["trace[73974210] 'process raft request' (duration: 147.803242ms)","trace[73974210] 'compare' (duration: 119.888097ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:51:15.34284Z","caller":"traceutil/trace.go:171","msg":"trace[781286852] linearizableReadLoop","detail":"{readStateIndex:4616; appliedIndex:4615; }","duration":"172.54394ms","start":"2026-04-17T18:51:15.170268Z","end":"2026-04-17T18:51:15.342812Z","steps":["trace[781286852] 'read index received' (duration: 76.814636ms)","trace[781286852] 'applied index is now lower than readState.Index' (duration: 95.728134ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:51:15.342883Z","caller":"traceutil/trace.go:171","msg":"trace[1411052063] transaction","detail":"{read_only:false; response_revision:4430; number_of_response:1; }","duration":"222.320484ms","start":"2026-04-17T18:51:15.120534Z","end":"2026-04-17T18:51:15.342854Z","steps":["trace[1411052063] 'process raft request' (duration: 126.438846ms)","trace[1411052063] 'compare' (duration: 95.720315ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:51:15.343008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.724485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8ffsp\" ","response":"range_response_count:1 size:6531"} {"level":"warn","ts":"2026-04-17T18:51:15.343035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.010041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T18:51:15.343056Z","caller":"traceutil/trace.go:171","msg":"trace[156658526] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8ffsp; range_end:; response_count:1; response_revision:4430; }","duration":"172.799976ms","start":"2026-04-17T18:51:15.170245Z","end":"2026-04-17T18:51:15.343045Z","steps":["trace[156658526] 'agreement among raft nodes before linearized reading' (duration: 172.669573ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:51:15.343072Z","caller":"traceutil/trace.go:171","msg":"trace[464966593] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:4430; }","duration":"167.077613ms","start":"2026-04-17T18:51:15.175984Z","end":"2026-04-17T18:51:15.343062Z","steps":["trace[464966593] 'agreement among raft nodes before linearized reading' (duration: 166.991481ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:51:28.557114Z","caller":"traceutil/trace.go:171","msg":"trace[1738182273] transaction","detail":"{read_only:false; response_revision:4691; number_of_response:1; }","duration":"107.163921ms","start":"2026-04-17T18:51:28.449904Z","end":"2026-04-17T18:51:28.557068Z","steps":["trace[1738182273] 'process raft request' (duration: 107.017438ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:51:35.972838Z","caller":"traceutil/trace.go:171","msg":"trace[1731976252] linearizableReadLoop","detail":"{readStateIndex:5060; appliedIndex:5059; }","duration":"129.652875ms","start":"2026-04-17T18:51:35.843159Z","end":"2026-04-17T18:51:35.972812Z","steps":["trace[1731976252] 'read index received' (duration: 85.167476ms)","trace[1731976252] 'applied index is now lower than readState.Index' (duration: 44.484299ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:51:35.972911Z","caller":"traceutil/trace.go:171","msg":"trace[1898786263] transaction","detail":"{read_only:false; response_revision:4857; number_of_response:1; }","duration":"186.88667ms","start":"2026-04-17T18:51:35.785991Z","end":"2026-04-17T18:51:35.972878Z","steps":["trace[1898786263] 'process raft request' (duration: 142.382341ms)","trace[1898786263] 'compare' (duration: 44.311195ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:51:35.973087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.914482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-04-17T18:51:35.973173Z","caller":"traceutil/trace.go:171","msg":"trace[168899706] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4857; }","duration":"130.056755ms","start":"2026-04-17T18:51:35.843095Z","end":"2026-04-17T18:51:35.973151Z","steps":["trace[168899706] 'agreement among raft nodes before linearized reading' (duration: 129.8167ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:51:35.973159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.504837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-48ed6504-6d5f-4234-96b8-31f87e10b41c\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-17T18:51:35.973254Z","caller":"traceutil/trace.go:171","msg":"trace[1519600815] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-48ed6504-6d5f-4234-96b8-31f87e10b41c; range_end:; response_count:1; response_revision:4857; }","duration":"100.65368ms","start":"2026-04-17T18:51:35.872585Z","end":"2026-04-17T18:51:35.973239Z","steps":["trace[1519600815] 'agreement among raft nodes before linearized reading' (duration: 100.400074ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:51:36.20913Z","caller":"traceutil/trace.go:171","msg":"trace[712230452] linearizableReadLoop","detail":"{readStateIndex:5062; appliedIndex:5061; }","duration":"114.53841ms","start":"2026-04-17T18:51:36.094558Z","end":"2026-04-17T18:51:36.209096Z","steps":["trace[712230452] 'read index received' (duration: 114.182162ms)","trace[712230452] 'applied index is now lower than readState.Index' (duration: 355.028µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:51:36.20955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.97762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-17T18:51:36.209691Z","caller":"traceutil/trace.go:171","msg":"trace[1588208992] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4859; }","duration":"115.162714ms","start":"2026-04-17T18:51:36.094508Z","end":"2026-04-17T18:51:36.209671Z","steps":["trace[1588208992] 'agreement among raft nodes before linearized reading' (duration: 114.836147ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:51:36.209694Z","caller":"traceutil/trace.go:171","msg":"trace[1702027988] transaction","detail":"{read_only:false; response_revision:4859; number_of_response:1; }","duration":"142.904441ms","start":"2026-04-17T18:51:36.066745Z","end":"2026-04-17T18:51:36.209649Z","steps":["trace[1702027988] 'process raft request' (duration: 142.099024ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:54:59.220034Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3251} {"level":"info","ts":"2026-04-17T18:54:59.302523Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3251,"took":"80.927786ms","hash":176918721,"current-db-size-bytes":60604416,"current-db-size":"61 MB","current-db-size-in-use-bytes":33718272,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-17T18:54:59.302607Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":176918721,"revision":3251,"compact-revision":-1} {"level":"info","ts":"2026-04-17T18:57:24.0204Z","caller":"traceutil/trace.go:171","msg":"trace[338988516] transaction","detail":"{read_only:false; response_revision:8043; number_of_response:1; }","duration":"114.02267ms","start":"2026-04-17T18:57:23.906346Z","end":"2026-04-17T18:57:24.020369Z","steps":["trace[338988516] 'process raft request' (duration: 82.789188ms)","trace[338988516] 'compare' (duration: 31.090149ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:57:35.585784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.803473ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T18:57:35.58593Z","caller":"traceutil/trace.go:171","msg":"trace[1749706685] linearizableReadLoop","detail":"{readStateIndex:8478; appliedIndex:8477; }","duration":"389.448889ms","start":"2026-04-17T18:57:35.196456Z","end":"2026-04-17T18:57:35.585905Z","steps":["trace[1749706685] 'read index received' (duration: 12.515543ms)","trace[1749706685] 'applied index is now lower than readState.Index' (duration: 376.931456ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:57:35.586064Z","caller":"traceutil/trace.go:171","msg":"trace[5931301] transaction","detail":"{read_only:false; response_revision:8118; number_of_response:1; }","duration":"424.635678ms","start":"2026-04-17T18:57:35.161412Z","end":"2026-04-17T18:57:35.586048Z","steps":["trace[5931301] 'process raft request' (duration: 47.466017ms)","trace[5931301] 'compare' (duration: 376.589509ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:57:35.586162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:57:35.1614Z","time spent":"424.71257ms","remote":"127.0.0.1:58466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T18:57:35.586184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.719635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T18:57:35.586251Z","caller":"traceutil/trace.go:171","msg":"trace[1977738007] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8118; }","duration":"389.815957ms","start":"2026-04-17T18:57:35.196414Z","end":"2026-04-17T18:57:35.58623Z","steps":["trace[1977738007] 'agreement among raft nodes before linearized reading' (duration: 389.717365ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:57:35.586255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.94573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8ffsp\" ","response":"range_response_count:1 size:6531"} {"level":"warn","ts":"2026-04-17T18:57:35.58631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:57:35.19638Z","time spent":"389.917819ms","remote":"127.0.0.1:58218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-17T18:57:35.586316Z","caller":"traceutil/trace.go:171","msg":"trace[1041765419] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8ffsp; range_end:; response_count:1; response_revision:8118; }","duration":"206.050823ms","start":"2026-04-17T18:57:35.380249Z","end":"2026-04-17T18:57:35.5863Z","steps":["trace[1041765419] 'agreement among raft nodes before linearized reading' (duration: 205.842748ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:57:35.586429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.495669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T18:57:35.586432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.759171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T18:57:35.586503Z","caller":"traceutil/trace.go:171","msg":"trace[1665906292] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:8118; }","duration":"194.622652ms","start":"2026-04-17T18:57:35.39186Z","end":"2026-04-17T18:57:35.586483Z","steps":["trace[1665906292] 'agreement among raft nodes before linearized reading' (duration: 194.461848ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:57:35.586562Z","caller":"traceutil/trace.go:171","msg":"trace[1831598429] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:8118; }","duration":"143.934834ms","start":"2026-04-17T18:57:35.44259Z","end":"2026-04-17T18:57:35.586525Z","steps":["trace[1831598429] 'agreement among raft nodes before linearized reading' (duration: 143.689179ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:57:36.229852Z","caller":"traceutil/trace.go:171","msg":"trace[804680427] transaction","detail":"{read_only:false; response_revision:8119; number_of_response:1; }","duration":"245.76054ms","start":"2026-04-17T18:57:35.984061Z","end":"2026-04-17T18:57:36.229822Z","steps":["trace[804680427] 'process raft request' (duration: 245.597326ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:57:36.443557Z","caller":"traceutil/trace.go:171","msg":"trace[413131687] linearizableReadLoop","detail":"{readStateIndex:8480; appliedIndex:8478; }","duration":"301.891586ms","start":"2026-04-17T18:57:36.141631Z","end":"2026-04-17T18:57:36.443523Z","steps":["trace[413131687] 'read index received' (duration: 88.023644ms)","trace[413131687] 'applied index is now lower than readState.Index' (duration: 213.866532ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:57:36.443727Z","caller":"traceutil/trace.go:171","msg":"trace[1434317240] transaction","detail":"{read_only:false; response_revision:8120; number_of_response:1; }","duration":"455.915071ms","start":"2026-04-17T18:57:35.987767Z","end":"2026-04-17T18:57:36.443682Z","steps":["trace[1434317240] 'process raft request' (duration: 399.782014ms)","trace[1434317240] 'compare' (duration: 55.686157ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:57:36.443786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.395753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T18:57:36.443849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.317418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:525"} {"level":"info","ts":"2026-04-17T18:57:36.443849Z","caller":"traceutil/trace.go:171","msg":"trace[356682405] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8120; }","duration":"246.504335ms","start":"2026-04-17T18:57:36.197327Z","end":"2026-04-17T18:57:36.443832Z","steps":["trace[356682405] 'agreement among raft nodes before linearized reading' (duration: 246.394953ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:57:36.443887Z","caller":"traceutil/trace.go:171","msg":"trace[1942675239] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:8120; }","duration":"217.38541ms","start":"2026-04-17T18:57:36.226491Z","end":"2026-04-17T18:57:36.443877Z","steps":["trace[1942675239] 'agreement among raft nodes before linearized reading' (duration: 217.243237ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:57:36.443899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:57:35.987754Z","time spent":"456.057825ms","remote":"127.0.0.1:58466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T18:57:36.443837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.202453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"} {"level":"warn","ts":"2026-04-17T18:57:36.443909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.33292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T18:57:36.443988Z","caller":"traceutil/trace.go:171","msg":"trace[801461240] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8120; }","duration":"302.382317ms","start":"2026-04-17T18:57:36.141577Z","end":"2026-04-17T18:57:36.443959Z","steps":["trace[801461240] 'agreement among raft nodes before linearized reading' (duration: 302.095551ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:57:36.444009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.789995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-17T18:57:36.44403Z","caller":"traceutil/trace.go:171","msg":"trace[1019258742] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:8120; }","duration":"147.516733ms","start":"2026-04-17T18:57:36.296487Z","end":"2026-04-17T18:57:36.444004Z","steps":["trace[1019258742] 'agreement among raft nodes before linearized reading' (duration: 147.291088ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:57:36.444061Z","caller":"traceutil/trace.go:171","msg":"trace[483634631] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8120; }","duration":"221.870438ms","start":"2026-04-17T18:57:36.222175Z","end":"2026-04-17T18:57:36.444045Z","steps":["trace[483634631] 'agreement among raft nodes before linearized reading' (duration: 221.677423ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:57:36.444062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:57:36.141557Z","time spent":"302.483908ms","remote":"127.0.0.1:58324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":684,"request content":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-04-17T18:57:36.444062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.264918ms","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-04-17T18:57:36.444138Z","caller":"traceutil/trace.go:171","msg":"trace[1207801709] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8120; }","duration":"218.374271ms","start":"2026-04-17T18:57:36.225745Z","end":"2026-04-17T18:57:36.44412Z","steps":["trace[1207801709] 'agreement among raft nodes before linearized reading' (duration: 218.115716ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:57:37.223302Z","caller":"traceutil/trace.go:171","msg":"trace[1770562316] transaction","detail":"{read_only:false; response_revision:8128; number_of_response:1; }","duration":"120.559484ms","start":"2026-04-17T18:57:37.102717Z","end":"2026-04-17T18:57:37.223276Z","steps":["trace[1770562316] 'process raft request' (duration: 120.213627ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:57:38.974441Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000213f.wal"} {"level":"info","ts":"2026-04-17T18:58:17.03249Z","caller":"traceutil/trace.go:171","msg":"trace[822166916] transaction","detail":"{read_only:false; response_revision:8489; number_of_response:1; }","duration":"393.535588ms","start":"2026-04-17T18:58:16.638927Z","end":"2026-04-17T18:58:17.032463Z","steps":["trace[822166916] 'process raft request' (duration: 393.361325ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:17.032714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:16.638911Z","time spent":"393.709072ms","remote":"127.0.0.1:58466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T18:58:17.23165Z","caller":"traceutil/trace.go:171","msg":"trace[38920724] linearizableReadLoop","detail":"{readStateIndex:8871; appliedIndex:8869; }","duration":"571.68585ms","start":"2026-04-17T18:58:16.65994Z","end":"2026-04-17T18:58:17.231626Z","steps":["trace[38920724] 'read index received' (duration: 372.482247ms)","trace[38920724] 'applied index is now lower than readState.Index' (duration: 199.202383ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:58:17.231712Z","caller":"traceutil/trace.go:171","msg":"trace[1605842513] transaction","detail":"{read_only:false; response_revision:8490; number_of_response:1; }","duration":"591.578815ms","start":"2026-04-17T18:58:16.640093Z","end":"2026-04-17T18:58:17.231672Z","steps":["trace[1605842513] 'process raft request' (duration: 498.068682ms)","trace[1605842513] 'compare' (duration: 93.246587ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:58:17.231776Z","caller":"traceutil/trace.go:171","msg":"trace[2083496816] transaction","detail":"{read_only:false; response_revision:8491; number_of_response:1; }","duration":"209.5744ms","start":"2026-04-17T18:58:17.022169Z","end":"2026-04-17T18:58:17.231743Z","steps":["trace[2083496816] 'process raft request' (duration: 209.391376ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:17.231836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:16.640066Z","time spent":"591.705048ms","remote":"127.0.0.1:58466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T18:58:17.231879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.919865ms","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-04-17T18:58:17.23193Z","caller":"traceutil/trace.go:171","msg":"trace[1016794664] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8491; }","duration":"571.999377ms","start":"2026-04-17T18:58:16.659915Z","end":"2026-04-17T18:58:17.231915Z","steps":["trace[1016794664] 'agreement among raft nodes before linearized reading' (duration: 571.847954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:17.232001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:16.659904Z","time spent":"572.079699ms","remote":"127.0.0.1:58466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-17T18:58:17.232051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.443138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:645"} {"level":"warn","ts":"2026-04-17T18:58:17.232061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.458115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-04-17T18:58:17.232158Z","caller":"traceutil/trace.go:171","msg":"trace[714865265] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:8491; }","duration":"565.584007ms","start":"2026-04-17T18:58:16.666553Z","end":"2026-04-17T18:58:17.232137Z","steps":["trace[714865265] 'agreement among raft nodes before linearized reading' (duration: 565.320421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:17.232185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.24396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"} {"level":"warn","ts":"2026-04-17T18:58:17.232204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:16.666541Z","time spent":"565.653949ms","remote":"127.0.0.1:58466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":550,"request content":"key:\"/registry/leases/openstack/08db1feb.percona.com\" "} {"level":"info","ts":"2026-04-17T18:58:17.23222Z","caller":"traceutil/trace.go:171","msg":"trace[1628746560] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8491; }","duration":"365.312472ms","start":"2026-04-17T18:58:16.866895Z","end":"2026-04-17T18:58:17.232207Z","steps":["trace[1628746560] 'agreement among raft nodes before linearized reading' (duration: 365.21958ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:17.232094Z","caller":"traceutil/trace.go:171","msg":"trace[1402453973] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8491; }","duration":"221.485419ms","start":"2026-04-17T18:58:17.010597Z","end":"2026-04-17T18:58:17.232082Z","steps":["trace[1402453973] 'agreement among raft nodes before linearized reading' (duration: 221.342386ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:17.232251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:16.866874Z","time spent":"365.371162ms","remote":"127.0.0.1:58324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":684,"request content":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" "} {"level":"info","ts":"2026-04-17T18:58:19.598141Z","caller":"traceutil/trace.go:171","msg":"trace[542245514] linearizableReadLoop","detail":"{readStateIndex:8890; appliedIndex:8888; }","duration":"174.038622ms","start":"2026-04-17T18:58:19.42408Z","end":"2026-04-17T18:58:19.598119Z","steps":["trace[542245514] 'read index received' (duration: 173.887219ms)","trace[542245514] 'applied index is now lower than readState.Index' (duration: 150.373µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:58:19.598176Z","caller":"traceutil/trace.go:171","msg":"trace[1164281425] transaction","detail":"{read_only:false; response_revision:8507; number_of_response:1; }","duration":"204.251523ms","start":"2026-04-17T18:58:19.393905Z","end":"2026-04-17T18:58:19.598156Z","steps":["trace[1164281425] 'process raft request' (duration: 204.008498ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:19.59836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.266147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:568"} {"level":"info","ts":"2026-04-17T18:58:19.598395Z","caller":"traceutil/trace.go:171","msg":"trace[186527430] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8508; }","duration":"174.336649ms","start":"2026-04-17T18:58:19.424046Z","end":"2026-04-17T18:58:19.598382Z","steps":["trace[186527430] 'agreement among raft nodes before linearized reading' (duration: 174.163265ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:19.598628Z","caller":"traceutil/trace.go:171","msg":"trace[782920246] transaction","detail":"{read_only:false; response_revision:8508; number_of_response:1; }","duration":"191.691448ms","start":"2026-04-17T18:58:19.406925Z","end":"2026-04-17T18:58:19.598616Z","steps":["trace[782920246] 'process raft request' (duration: 191.133406ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:59:23.422298Z","caller":"traceutil/trace.go:171","msg":"trace[1292741904] transaction","detail":"{read_only:false; response_revision:9213; number_of_response:1; }","duration":"130.904663ms","start":"2026-04-17T18:59:23.291348Z","end":"2026-04-17T18:59:23.422253Z","steps":["trace[1292741904] 'process raft request' (duration: 130.585157ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:59:59.230335Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6608} {"level":"info","ts":"2026-04-17T18:59:59.325949Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6608,"took":"93.432172ms","hash":1038459760,"current-db-size-bytes":60604416,"current-db-size":"61 MB","current-db-size-in-use-bytes":27287552,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-04-17T18:59:59.326033Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1038459760,"revision":6608,"compact-revision":3251} {"level":"info","ts":"2026-04-17T19:00:03.929395Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c51d7a9ea5537d6e","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-17T19:00:03.936697Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-17T19:00:03.937066Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-17T19:04:59.236934Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9538} {"level":"info","ts":"2026-04-17T19:04:59.324857Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9538,"took":"85.647222ms","hash":896209767,"current-db-size-bytes":60604416,"current-db-size":"61 MB","current-db-size-in-use-bytes":25034752,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-17T19:04:59.324918Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":896209767,"revision":9538,"compact-revision":6608}