{"level":"warn","ts":"2026-08-14T23:14:52.964845Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-14T23:14:52.964953Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.72: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.204.45.72:2380","--initial-cluster=instance=https://199.204.45.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.72:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-08-14T23:14:52.96503Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-14T23:14:52.965046Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-08-14T23:14:52.965062Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-14T23:14:52.965631Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"]} {"level":"info","ts":"2026-08-14T23:14:52.965704Z","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.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.72:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-08-14T23:14:52.970328Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.407414ms"} {"level":"info","ts":"2026-08-14T23:14:52.978762Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"50e03cebfd94cbba","cluster-id":"120c03c1d5b80f94"} {"level":"info","ts":"2026-08-14T23:14:52.978881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=()"} {"level":"info","ts":"2026-08-14T23:14:52.978916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 0"} {"level":"info","ts":"2026-08-14T23:14:52.979004Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 50e03cebfd94cbba [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-14T23:14:52.979015Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 1"} {"level":"info","ts":"2026-08-14T23:14:52.979064Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"warn","ts":"2026-08-14T23:14:52.988869Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-14T23:14:52.991781Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-14T23:14:52.993448Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-08-14T23:14:52.996301Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"50e03cebfd94cbba","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-14T23:14:52.996504Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"50e03cebfd94cbba","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-14T23:14:52.996676Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-14T23:14:52.996793Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-14T23:14:52.996839Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-14T23:14:52.997574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"info","ts":"2026-08-14T23:14:52.997787Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","added-peer-id":"50e03cebfd94cbba","added-peer-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-08-14T23:14:52.999548Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-14T23:14:52.999653Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-08-14T23:14:52.999748Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-08-14T23:14:53.000076Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"50e03cebfd94cbba","initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-14T23:14:53.000134Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-14T23:14:53.779629Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba is starting a new election at term 1"} {"level":"info","ts":"2026-08-14T23:14:53.779705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became pre-candidate at term 1"} {"level":"info","ts":"2026-08-14T23:14:53.779751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgPreVoteResp from 50e03cebfd94cbba at term 1"} {"level":"info","ts":"2026-08-14T23:14:53.779837Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became candidate at term 2"} {"level":"info","ts":"2026-08-14T23:14:53.77985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgVoteResp from 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-08-14T23:14:53.779867Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became leader at term 2"} {"level":"info","ts":"2026-08-14T23:14:53.779888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 50e03cebfd94cbba elected leader 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-08-14T23:14:53.816314Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"50e03cebfd94cbba","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.72:2379]}","request-path":"/0/members/50e03cebfd94cbba/attributes","cluster-id":"120c03c1d5b80f94","publish-timeout":"7s"} {"level":"info","ts":"2026-08-14T23:14:53.816342Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-14T23:14:53.816373Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-14T23:14:53.816543Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T23:14:53.816804Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-14T23:14:53.81688Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-14T23:14:53.818288Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T23:14:53.818576Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T23:14:53.818632Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T23:14:53.819709Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.72:2379"} {"level":"info","ts":"2026-08-14T23:14:53.82019Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-14T23:15:19.81059Z","caller":"traceutil/trace.go:171","msg":"trace[1627404902] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"111.414968ms","start":"2026-08-14T23:15:19.699115Z","end":"2026-08-14T23:15:19.81053Z","steps":["trace[1627404902] 'process raft request' (duration: 111.220152ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:15:19.892643Z","caller":"traceutil/trace.go:171","msg":"trace[1568901093] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"193.458159ms","start":"2026-08-14T23:15:19.699165Z","end":"2026-08-14T23:15:19.892624Z","steps":["trace[1568901093] 'process raft request' (duration: 193.357757ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:15:36.712338Z","caller":"traceutil/trace.go:171","msg":"trace[918821943] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"155.82701ms","start":"2026-08-14T23:15:36.556463Z","end":"2026-08-14T23:15:36.71229Z","steps":["trace[918821943] 'process raft request' (duration: 155.360268ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:36.919719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.580405ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T23:15:36.919877Z","caller":"traceutil/trace.go:171","msg":"trace[379038287] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:610; }","duration":"124.984676ms","start":"2026-08-14T23:15:36.794875Z","end":"2026-08-14T23:15:36.91986Z","steps":["trace[379038287] 'read index received' (duration: 125.153µs)","trace[379038287] 'applied index is now lower than readState.Index' (duration: 124.858113ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:15:36.919974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.10744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:15:36.920006Z","caller":"traceutil/trace.go:171","msg":"trace[607616169] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:586; }","duration":"125.190362ms","start":"2026-08-14T23:15:36.794805Z","end":"2026-08-14T23:15:36.919995Z","steps":["trace[607616169] 'agreement among raft nodes before linearized reading' (duration: 125.137121ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:15:36.920002Z","caller":"traceutil/trace.go:171","msg":"trace[1256468593] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"183.743299ms","start":"2026-08-14T23:15:36.736209Z","end":"2026-08-14T23:15:36.919952Z","steps":["trace[1256468593] 'process raft request' (duration: 53.440865ms)","trace[1256468593] 'compare' (duration: 129.39418ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:15:37.522014Z","caller":"traceutil/trace.go:171","msg":"trace[1928850931] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"365.856176ms","start":"2026-08-14T23:15:37.156121Z","end":"2026-08-14T23:15:37.521977Z","steps":["trace[1928850931] 'process raft request' (duration: 364.44912ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:37.522309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:15:37.156084Z","time spent":"366.01938ms","remote":"127.0.0.1:44422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:15:37.60002Z","caller":"traceutil/trace.go:171","msg":"trace[1144358299] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:612; }","duration":"142.917908ms","start":"2026-08-14T23:15:37.457077Z","end":"2026-08-14T23:15:37.599995Z","steps":["trace[1144358299] 'read index received' (duration: 63.557135ms)","trace[1144358299] 'applied index is now lower than readState.Index' (duration: 79.359973ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:15:37.600127Z","caller":"traceutil/trace.go:171","msg":"trace[352729996] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"268.10438ms","start":"2026-08-14T23:15:37.331973Z","end":"2026-08-14T23:15:37.600078Z","steps":["trace[352729996] 'process raft request' (duration: 267.470434ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:37.600225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.130504ms","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-08-14T23:15:37.600253Z","caller":"traceutil/trace.go:171","msg":"trace[546060729] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:588; }","duration":"143.231446ms","start":"2026-08-14T23:15:37.457013Z","end":"2026-08-14T23:15:37.600244Z","steps":["trace[546060729] 'agreement among raft nodes before linearized reading' (duration: 143.087523ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:51.837531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.904065ms","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-08-14T23:15:51.83766Z","caller":"traceutil/trace.go:171","msg":"trace[484917878] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:753; }","duration":"160.109971ms","start":"2026-08-14T23:15:51.677525Z","end":"2026-08-14T23:15:51.837635Z","steps":["trace[484917878] 'range keys from in-memory index tree' (duration: 159.636398ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:15:51.837704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.670555ms","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-08-14T23:15:51.837802Z","caller":"traceutil/trace.go:171","msg":"trace[1067203219] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:753; }","duration":"160.824259ms","start":"2026-08-14T23:15:51.676956Z","end":"2026-08-14T23:15:51.83778Z","steps":["trace[1067203219] 'range keys from in-memory index tree' (duration: 160.179973ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:16:29.665234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.958337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:16:29.665373Z","caller":"traceutil/trace.go:171","msg":"trace[793237004] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1189; }","duration":"123.177323ms","start":"2026-08-14T23:16:29.542171Z","end":"2026-08-14T23:16:29.665348Z","steps":["trace[793237004] 'range keys from in-memory index tree' (duration: 122.831314ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:17:14.367668Z","caller":"traceutil/trace.go:171","msg":"trace[133511860] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"128.683189ms","start":"2026-08-14T23:17:14.238953Z","end":"2026-08-14T23:17:14.367636Z","steps":["trace[133511860] 'process raft request' (duration: 128.511055ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:14.72411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.528614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:17:14.72421Z","caller":"traceutil/trace.go:171","msg":"trace[621898687] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1841; }","duration":"182.659859ms","start":"2026-08-14T23:17:14.541529Z","end":"2026-08-14T23:17:14.724189Z","steps":["trace[621898687] 'range keys from in-memory index tree' (duration: 182.469693ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:17:14.724296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.587589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-14T23:17:14.724409Z","caller":"traceutil/trace.go:171","msg":"trace[870764940] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1841; }","duration":"189.836276ms","start":"2026-08-14T23:17:14.534551Z","end":"2026-08-14T23:17:14.724387Z","steps":["trace[870764940] 'range keys from in-memory index tree' (duration: 189.456096ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:17:14.724614Z","caller":"traceutil/trace.go:171","msg":"trace[753877612] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"151.300709ms","start":"2026-08-14T23:17:14.573296Z","end":"2026-08-14T23:17:14.724597Z","steps":["trace[753877612] 'process raft request' (duration: 106.651594ms)","trace[753877612] 'compare' (duration: 43.974018ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:17:59.094216Z","caller":"traceutil/trace.go:171","msg":"trace[1670180990] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"149.247525ms","start":"2026-08-14T23:17:58.944922Z","end":"2026-08-14T23:17:59.094169Z","steps":["trace[1670180990] 'process raft request' (duration: 122.121477ms)","trace[1670180990] 'compare' (duration: 26.544963ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:19:27.930785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.787777ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T23:19:27.930908Z","caller":"traceutil/trace.go:171","msg":"trace[1037102915] linearizableReadLoop","detail":"{readStateIndex:2927; appliedIndex:2926; }","duration":"194.437029ms","start":"2026-08-14T23:19:27.736453Z","end":"2026-08-14T23:19:27.93089Z","steps":["trace[1037102915] 'read index received' (duration: 51.365404ms)","trace[1037102915] 'applied index is now lower than readState.Index' (duration: 143.070155ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:19:27.931049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.592193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-08-14T23:19:27.931085Z","caller":"traceutil/trace.go:171","msg":"trace[1189945005] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2814; }","duration":"194.669005ms","start":"2026-08-14T23:19:27.736403Z","end":"2026-08-14T23:19:27.931072Z","steps":["trace[1189945005] 'agreement among raft nodes before linearized reading' (duration: 194.552102ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:19:27.931073Z","caller":"traceutil/trace.go:171","msg":"trace[1503196297] transaction","detail":"{read_only:false; response_revision:2814; number_of_response:1; }","duration":"270.801338ms","start":"2026-08-14T23:19:27.66024Z","end":"2026-08-14T23:19:27.931041Z","steps":["trace[1503196297] 'process raft request' (duration: 127.678962ms)","trace[1503196297] 'compare' (duration: 142.678025ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:19:28.044973Z","caller":"traceutil/trace.go:171","msg":"trace[1483162145] transaction","detail":"{read_only:false; response_revision:2815; number_of_response:1; }","duration":"117.203948ms","start":"2026-08-14T23:19:27.927737Z","end":"2026-08-14T23:19:28.044941Z","steps":["trace[1483162145] 'process raft request' (duration: 117.042454ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:19:28.046215Z","caller":"traceutil/trace.go:171","msg":"trace[1389653738] transaction","detail":"{read_only:false; response_revision:2816; number_of_response:1; }","duration":"111.141259ms","start":"2026-08-14T23:19:27.935046Z","end":"2026-08-14T23:19:28.046187Z","steps":["trace[1389653738] 'process raft request' (duration: 110.979155ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:21:52.96072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.963345ms","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-08-14T23:21:52.960815Z","caller":"traceutil/trace.go:171","msg":"trace[1718753481] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3778; }","duration":"159.111388ms","start":"2026-08-14T23:21:52.801683Z","end":"2026-08-14T23:21:52.960794Z","steps":["trace[1718753481] 'range keys from in-memory index tree' (duration: 158.80344ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:21:52.961028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.535563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-08-14T23:21:52.961121Z","caller":"traceutil/trace.go:171","msg":"trace[704182308] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:3778; }","duration":"158.696528ms","start":"2026-08-14T23:21:52.802404Z","end":"2026-08-14T23:21:52.961101Z","steps":["trace[704182308] 'range keys from in-memory index tree' (duration: 158.308007ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:23:15.94747Z","caller":"traceutil/trace.go:171","msg":"trace[2024790625] linearizableReadLoop","detail":"{readStateIndex:5164; appliedIndex:5163; }","duration":"193.007194ms","start":"2026-08-14T23:23:15.754443Z","end":"2026-08-14T23:23:15.94745Z","steps":["trace[2024790625] 'read index received' (duration: 192.87167ms)","trace[2024790625] 'applied index is now lower than readState.Index' (duration: 134.784µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:23:15.947527Z","caller":"traceutil/trace.go:171","msg":"trace[1914367600] transaction","detail":"{read_only:false; response_revision:4973; number_of_response:1; }","duration":"198.717093ms","start":"2026-08-14T23:23:15.748778Z","end":"2026-08-14T23:23:15.947495Z","steps":["trace[1914367600] 'process raft request' (duration: 198.541448ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:23:15.947704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.24931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:1219"} {"level":"info","ts":"2026-08-14T23:23:15.947751Z","caller":"traceutil/trace.go:171","msg":"trace[775916440] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4973; }","duration":"193.354763ms","start":"2026-08-14T23:23:15.754382Z","end":"2026-08-14T23:23:15.947737Z","steps":["trace[775916440] 'agreement among raft nodes before linearized reading' (duration: 193.164458ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:23:16.055798Z","caller":"traceutil/trace.go:171","msg":"trace[1918849808] linearizableReadLoop","detail":"{readStateIndex:5165; appliedIndex:5164; }","duration":"106.535394ms","start":"2026-08-14T23:23:15.94924Z","end":"2026-08-14T23:23:16.055775Z","steps":["trace[1918849808] 'read index received' (duration: 106.333398ms)","trace[1918849808] 'applied index is now lower than readState.Index' (duration: 201.176µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:23:16.055915Z","caller":"traceutil/trace.go:171","msg":"trace[2020652653] transaction","detail":"{read_only:false; response_revision:4974; number_of_response:1; }","duration":"283.767385ms","start":"2026-08-14T23:23:15.772114Z","end":"2026-08-14T23:23:16.055882Z","steps":["trace[2020652653] 'process raft request' (duration: 283.531529ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:23:16.056092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.830992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16230"} {"level":"info","ts":"2026-08-14T23:23:16.05616Z","caller":"traceutil/trace.go:171","msg":"trace[916053498] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4974; }","duration":"106.938054ms","start":"2026-08-14T23:23:15.949205Z","end":"2026-08-14T23:23:16.056143Z","steps":["trace[916053498] 'agreement among raft nodes before linearized reading' (duration: 106.693648ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:23:18.385233Z","caller":"traceutil/trace.go:171","msg":"trace[259252355] linearizableReadLoop","detail":"{readStateIndex:5209; appliedIndex:5207; }","duration":"100.743343ms","start":"2026-08-14T23:23:18.28446Z","end":"2026-08-14T23:23:18.385204Z","steps":["trace[259252355] 'read index received' (duration: 85.344711ms)","trace[259252355] 'applied index is now lower than readState.Index' (duration: 15.397112ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:23:18.385497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.01465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-14T23:23:18.38554Z","caller":"traceutil/trace.go:171","msg":"trace[1696050087] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5016; }","duration":"101.116572ms","start":"2026-08-14T23:23:18.284412Z","end":"2026-08-14T23:23:18.385528Z","steps":["trace[1696050087] 'agreement among raft nodes before linearized reading' (duration: 100.911587ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:23:18.385506Z","caller":"traceutil/trace.go:171","msg":"trace[1224480634] transaction","detail":"{read_only:false; response_revision:5016; number_of_response:1; }","duration":"102.225251ms","start":"2026-08-14T23:23:18.283223Z","end":"2026-08-14T23:23:18.385448Z","steps":["trace[1224480634] 'process raft request' (duration: 101.826601ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:23:30.404742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.36826ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T23:23:30.405089Z","caller":"traceutil/trace.go:171","msg":"trace[1978850585] linearizableReadLoop","detail":"{readStateIndex:5448; appliedIndex:5446; }","duration":"203.793016ms","start":"2026-08-14T23:23:30.201275Z","end":"2026-08-14T23:23:30.405068Z","steps":["trace[1978850585] 'read index received' (duration: 92.032415ms)","trace[1978850585] 'applied index is now lower than readState.Index' (duration: 111.759211ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:23:30.405153Z","caller":"traceutil/trace.go:171","msg":"trace[574994360] transaction","detail":"{read_only:false; response_revision:5246; number_of_response:1; }","duration":"204.004581ms","start":"2026-08-14T23:23:30.201078Z","end":"2026-08-14T23:23:30.405082Z","steps":["trace[574994360] 'process raft request' (duration: 92.167579ms)","trace[574994360] 'compare' (duration: 111.034321ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:23:30.405168Z","caller":"traceutil/trace.go:171","msg":"trace[592898650] transaction","detail":"{read_only:false; response_revision:5247; number_of_response:1; }","duration":"203.915079ms","start":"2026-08-14T23:23:30.201197Z","end":"2026-08-14T23:23:30.405112Z","steps":["trace[592898650] 'process raft request' (duration: 203.763585ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:23:30.405355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.053783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:124184"} {"level":"info","ts":"2026-08-14T23:23:30.405439Z","caller":"traceutil/trace.go:171","msg":"trace[2015702592] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:5247; }","duration":"204.168345ms","start":"2026-08-14T23:23:30.201251Z","end":"2026-08-14T23:23:30.405419Z","steps":["trace[2015702592] 'agreement among raft nodes before linearized reading' (duration: 203.872137ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:23:38.677876Z","caller":"traceutil/trace.go:171","msg":"trace[805054960] linearizableReadLoop","detail":"{readStateIndex:5611; appliedIndex:5609; }","duration":"118.27715ms","start":"2026-08-14T23:23:38.559574Z","end":"2026-08-14T23:23:38.677851Z","steps":["trace[805054960] 'read index received' (duration: 32.480409ms)","trace[805054960] 'applied index is now lower than readState.Index' (duration: 85.795551ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:23:38.677921Z","caller":"traceutil/trace.go:171","msg":"trace[1356005604] transaction","detail":"{read_only:false; response_revision:5408; number_of_response:1; }","duration":"118.351022ms","start":"2026-08-14T23:23:38.559531Z","end":"2026-08-14T23:23:38.677882Z","steps":["trace[1356005604] 'process raft request' (duration: 118.113506ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:23:38.677963Z","caller":"traceutil/trace.go:171","msg":"trace[871059345] transaction","detail":"{read_only:false; response_revision:5409; number_of_response:1; }","duration":"117.872229ms","start":"2026-08-14T23:23:38.560057Z","end":"2026-08-14T23:23:38.677929Z","steps":["trace[871059345] 'process raft request' (duration: 117.750356ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:23:38.678052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.448335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:23:38.678099Z","caller":"traceutil/trace.go:171","msg":"trace[1135783077] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:5409; }","duration":"118.533666ms","start":"2026-08-14T23:23:38.559552Z","end":"2026-08-14T23:23:38.678086Z","steps":["trace[1135783077] 'agreement among raft nodes before linearized reading' (duration: 118.437764ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:23:48.508647Z","caller":"traceutil/trace.go:171","msg":"trace[99313970] transaction","detail":"{read_only:false; response_revision:5563; number_of_response:1; }","duration":"114.808829ms","start":"2026-08-14T23:23:48.393793Z","end":"2026-08-14T23:23:48.508602Z","steps":["trace[99313970] 'process raft request' (duration: 114.505381ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:23:48.835762Z","caller":"traceutil/trace.go:171","msg":"trace[1530301801] transaction","detail":"{read_only:false; response_revision:5570; number_of_response:1; }","duration":"106.452801ms","start":"2026-08-14T23:23:48.729274Z","end":"2026-08-14T23:23:48.835727Z","steps":["trace[1530301801] 'process raft request' (duration: 60.955422ms)","trace[1530301801] 'compare' (duration: 45.14939ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:24:53.879853Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2957} {"level":"info","ts":"2026-08-14T23:24:53.953607Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2957,"took":"72.195456ms","hash":1993822372,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":34127872,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-14T23:24:53.953683Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1993822372,"revision":2957,"compact-revision":-1} {"level":"info","ts":"2026-08-14T23:29:33.614521Z","caller":"traceutil/trace.go:171","msg":"trace[8332270] transaction","detail":"{read_only:false; response_revision:8186; number_of_response:1; }","duration":"248.691633ms","start":"2026-08-14T23:29:33.3658Z","end":"2026-08-14T23:29:33.614492Z","steps":["trace[8332270] 'process raft request' (duration: 248.504618ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:29:33.682593Z","caller":"traceutil/trace.go:171","msg":"trace[1828403184] linearizableReadLoop","detail":"{readStateIndex:8479; appliedIndex:8477; }","duration":"236.543317ms","start":"2026-08-14T23:29:33.446028Z","end":"2026-08-14T23:29:33.682571Z","steps":["trace[1828403184] 'read index received' (duration: 168.38999ms)","trace[1828403184] 'applied index is now lower than readState.Index' (duration: 68.151937ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:29:33.682688Z","caller":"traceutil/trace.go:171","msg":"trace[1775414579] transaction","detail":"{read_only:false; response_revision:8188; number_of_response:1; }","duration":"201.604785ms","start":"2026-08-14T23:29:33.481055Z","end":"2026-08-14T23:29:33.68266Z","steps":["trace[1775414579] 'process raft request' (duration: 201.469371ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:29:33.682773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.725991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T23:29:33.682818Z","caller":"traceutil/trace.go:171","msg":"trace[1856440644] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:8188; }","duration":"236.840694ms","start":"2026-08-14T23:29:33.445968Z","end":"2026-08-14T23:29:33.682809Z","steps":["trace[1856440644] 'agreement among raft nodes before linearized reading' (duration: 236.736971ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:29:33.682876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.296077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T23:29:33.682887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.889027ms","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-08-14T23:29:33.68298Z","caller":"traceutil/trace.go:171","msg":"trace[655269311] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8188; }","duration":"140.444891ms","start":"2026-08-14T23:29:33.542516Z","end":"2026-08-14T23:29:33.682961Z","steps":["trace[655269311] 'agreement among raft nodes before linearized reading' (duration: 140.266536ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:29:33.682989Z","caller":"traceutil/trace.go:171","msg":"trace[1960132925] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:8188; }","duration":"234.090122ms","start":"2026-08-14T23:29:33.448881Z","end":"2026-08-14T23:29:33.682971Z","steps":["trace[1960132925] 'agreement among raft nodes before linearized reading' (duration: 233.887827ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:29:33.682892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.084151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T23:29:33.683081Z","caller":"traceutil/trace.go:171","msg":"trace[1147190128] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:8188; }","duration":"163.321847ms","start":"2026-08-14T23:29:33.519742Z","end":"2026-08-14T23:29:33.683064Z","steps":["trace[1147190128] 'agreement among raft nodes before linearized reading' (duration: 163.067801ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:29:33.682681Z","caller":"traceutil/trace.go:171","msg":"trace[448607498] transaction","detail":"{read_only:false; response_revision:8187; number_of_response:1; }","duration":"316.618063ms","start":"2026-08-14T23:29:33.366016Z","end":"2026-08-14T23:29:33.682634Z","steps":["trace[448607498] 'process raft request' (duration: 316.09963ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:29:33.683526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:29:33.366Z","time spent":"317.425825ms","remote":"127.0.0.1:44626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T23:29:53.88834Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6102} {"level":"info","ts":"2026-08-14T23:29:54.011433Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6102,"took":"120.797289ms","hash":2033214094,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":23285760,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-08-14T23:29:54.011519Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2033214094,"revision":6102,"compact-revision":2957} {"level":"warn","ts":"2026-08-14T23:30:12.767116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.862944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T23:30:12.767162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.283304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-14T23:30:12.767244Z","caller":"traceutil/trace.go:171","msg":"trace[1555271564] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8446; }","duration":"132.430708ms","start":"2026-08-14T23:30:12.634795Z","end":"2026-08-14T23:30:12.767226Z","steps":["trace[1555271564] 'range keys from in-memory index tree' (duration: 132.063809ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:30:12.767198Z","caller":"traceutil/trace.go:171","msg":"trace[1041701576] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8446; }","duration":"224.995738ms","start":"2026-08-14T23:30:12.542184Z","end":"2026-08-14T23:30:12.76718Z","steps":["trace[1041701576] 'range keys from in-memory index tree' (duration: 224.802883ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:30:12.767389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.652378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-14T23:30:12.767452Z","caller":"traceutil/trace.go:171","msg":"trace[1253685203] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8446; }","duration":"141.72605ms","start":"2026-08-14T23:30:12.625708Z","end":"2026-08-14T23:30:12.767434Z","steps":["trace[1253685203] 'range keys from in-memory index tree' (duration: 141.555406ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:30:12.767474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.911499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:30:12.767663Z","caller":"traceutil/trace.go:171","msg":"trace[1905992129] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:8446; }","duration":"136.447972ms","start":"2026-08-14T23:30:12.631188Z","end":"2026-08-14T23:30:12.767636Z","steps":["trace[1905992129] 'count revisions from in-memory index tree' (duration: 135.808926ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:30:12.90109Z","caller":"traceutil/trace.go:171","msg":"trace[193477683] transaction","detail":"{read_only:false; response_revision:8447; number_of_response:1; }","duration":"128.675111ms","start":"2026-08-14T23:30:12.772386Z","end":"2026-08-14T23:30:12.901061Z","steps":["trace[193477683] 'process raft request' (duration: 128.517666ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:30:12.909944Z","caller":"traceutil/trace.go:171","msg":"trace[1177840301] linearizableReadLoop","detail":"{readStateIndex:8752; appliedIndex:8750; }","duration":"105.287781ms","start":"2026-08-14T23:30:12.804639Z","end":"2026-08-14T23:30:12.909927Z","steps":["trace[1177840301] 'read index received' (duration: 96.253466ms)","trace[1177840301] 'applied index is now lower than readState.Index' (duration: 9.033415ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:30:12.910062Z","caller":"traceutil/trace.go:171","msg":"trace[1566681996] transaction","detail":"{read_only:false; response_revision:8448; number_of_response:1; }","duration":"137.154401ms","start":"2026-08-14T23:30:12.772885Z","end":"2026-08-14T23:30:12.910039Z","steps":["trace[1566681996] 'process raft request' (duration: 136.961986ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:30:12.910228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.564258ms","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-08-14T23:30:12.910492Z","caller":"traceutil/trace.go:171","msg":"trace[736280999] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8448; }","duration":"105.869447ms","start":"2026-08-14T23:30:12.804608Z","end":"2026-08-14T23:30:12.910477Z","steps":["trace[736280999] 'agreement among raft nodes before linearized reading' (duration: 105.459116ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:30:14.521706Z","caller":"traceutil/trace.go:171","msg":"trace[269368330] transaction","detail":"{read_only:false; response_revision:8458; number_of_response:1; }","duration":"119.976194ms","start":"2026-08-14T23:30:14.401687Z","end":"2026-08-14T23:30:14.521664Z","steps":["trace[269368330] 'process raft request' (duration: 81.526793ms)","trace[269368330] 'compare' (duration: 38.282167ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:30:25.167997Z","caller":"traceutil/trace.go:171","msg":"trace[1861481596] linearizableReadLoop","detail":"{readStateIndex:8864; appliedIndex:8863; }","duration":"144.829721ms","start":"2026-08-14T23:30:25.023134Z","end":"2026-08-14T23:30:25.167963Z","steps":["trace[1861481596] 'read index received' (duration: 115.778435ms)","trace[1861481596] 'applied index is now lower than readState.Index' (duration: 29.049926ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:30:25.168092Z","caller":"traceutil/trace.go:171","msg":"trace[1071263338] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8555; }","duration":"157.325476ms","start":"2026-08-14T23:30:25.010718Z","end":"2026-08-14T23:30:25.168043Z","steps":["trace[1071263338] 'process raft request' (duration: 128.215368ms)","trace[1071263338] 'compare' (duration: 28.902043ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:30:25.168217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.065157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-dcj98\" ","response":"range_response_count:1 size:4647"} {"level":"info","ts":"2026-08-14T23:30:25.168288Z","caller":"traceutil/trace.go:171","msg":"trace[311008668] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-dcj98; range_end:; response_count:1; response_revision:8555; }","duration":"145.1572ms","start":"2026-08-14T23:30:25.023113Z","end":"2026-08-14T23:30:25.16827Z","steps":["trace[311008668] 'agreement among raft nodes before linearized reading' (duration: 144.973785ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:30:25.752027Z","caller":"traceutil/trace.go:171","msg":"trace[147885837] transaction","detail":"{read_only:false; response_revision:8557; number_of_response:1; }","duration":"127.347436ms","start":"2026-08-14T23:30:25.624647Z","end":"2026-08-14T23:30:25.751994Z","steps":["trace[147885837] 'process raft request' (duration: 127.172572ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:30:25.839973Z","caller":"traceutil/trace.go:171","msg":"trace[2065191156] transaction","detail":"{read_only:false; response_revision:8558; number_of_response:1; }","duration":"208.742385ms","start":"2026-08-14T23:30:25.631189Z","end":"2026-08-14T23:30:25.839931Z","steps":["trace[2065191156] 'process raft request' (duration: 199.964176ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:30:26.122885Z","caller":"traceutil/trace.go:171","msg":"trace[1187752678] transaction","detail":"{read_only:false; response_revision:8560; number_of_response:1; }","duration":"238.256654ms","start":"2026-08-14T23:30:25.884595Z","end":"2026-08-14T23:30:26.122852Z","steps":["trace[1187752678] 'process raft request' (duration: 223.792257ms)","trace[1187752678] 'compare' (duration: 14.247721ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:30:26.135283Z","caller":"traceutil/trace.go:171","msg":"trace[1697305257] linearizableReadLoop","detail":"{readStateIndex:8870; appliedIndex:8868; }","duration":"136.655288ms","start":"2026-08-14T23:30:25.998595Z","end":"2026-08-14T23:30:26.13525Z","steps":["trace[1697305257] 'read index received' (duration: 109.756227ms)","trace[1697305257] 'applied index is now lower than readState.Index' (duration: 26.897171ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:30:26.135338Z","caller":"traceutil/trace.go:171","msg":"trace[2020547213] transaction","detail":"{read_only:false; response_revision:8561; number_of_response:1; }","duration":"138.726032ms","start":"2026-08-14T23:30:25.996585Z","end":"2026-08-14T23:30:26.135311Z","steps":["trace[2020547213] 'process raft request' (duration: 138.481536ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:30:26.135459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.833063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:30:26.135513Z","caller":"traceutil/trace.go:171","msg":"trace[610909256] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:8561; }","duration":"136.910555ms","start":"2026-08-14T23:30:25.998587Z","end":"2026-08-14T23:30:26.135497Z","steps":["trace[610909256] 'agreement among raft nodes before linearized reading' (duration: 136.803502ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:30:26.135608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.875304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-08-14T23:30:26.136072Z","caller":"traceutil/trace.go:171","msg":"trace[428463717] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8561; }","duration":"137.393307ms","start":"2026-08-14T23:30:25.998657Z","end":"2026-08-14T23:30:26.13605Z","steps":["trace[428463717] 'agreement among raft nodes before linearized reading' (duration: 136.782011ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:30:26.687102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.396382ms","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-08-14T23:30:26.687201Z","caller":"traceutil/trace.go:171","msg":"trace[1295575775] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:8563; }","duration":"131.567546ms","start":"2026-08-14T23:30:26.555611Z","end":"2026-08-14T23:30:26.687178Z","steps":["trace[1295575775] 'count revisions from in-memory index tree' (duration: 131.279238ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:30:26.715582Z","caller":"traceutil/trace.go:171","msg":"trace[527200097] transaction","detail":"{read_only:false; response_revision:8564; number_of_response:1; }","duration":"153.701193ms","start":"2026-08-14T23:30:26.561845Z","end":"2026-08-14T23:30:26.715546Z","steps":["trace[527200097] 'process raft request' (duration: 153.490647ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:30:26.830311Z","caller":"traceutil/trace.go:171","msg":"trace[418756463] linearizableReadLoop","detail":"{readStateIndex:8874; appliedIndex:8873; }","duration":"101.082742ms","start":"2026-08-14T23:30:26.729199Z","end":"2026-08-14T23:30:26.830282Z","steps":["trace[418756463] 'read index received' (duration: 60.807173ms)","trace[418756463] 'applied index is now lower than readState.Index' (duration: 40.273949ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:30:26.830354Z","caller":"traceutil/trace.go:171","msg":"trace[1238243412] transaction","detail":"{read_only:false; response_revision:8565; number_of_response:1; }","duration":"101.183785ms","start":"2026-08-14T23:30:26.729135Z","end":"2026-08-14T23:30:26.830318Z","steps":["trace[1238243412] 'process raft request' (duration: 60.912767ms)","trace[1238243412] 'compare' (duration: 40.097313ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:30:26.830535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.296947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T23:30:26.830648Z","caller":"traceutil/trace.go:171","msg":"trace[813293067] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:8565; }","duration":"101.428861ms","start":"2026-08-14T23:30:26.729191Z","end":"2026-08-14T23:30:26.83062Z","steps":["trace[813293067] 'agreement among raft nodes before linearized reading' (duration: 101.230456ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:30:27.016445Z","caller":"traceutil/trace.go:171","msg":"trace[1818336808] linearizableReadLoop","detail":"{readStateIndex:8875; appliedIndex:8874; }","duration":"103.792363ms","start":"2026-08-14T23:30:26.91263Z","end":"2026-08-14T23:30:27.016422Z","steps":["trace[1818336808] 'read index received' (duration: 75.802394ms)","trace[1818336808] 'applied index is now lower than readState.Index' (duration: 27.988849ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:30:27.016536Z","caller":"traceutil/trace.go:171","msg":"trace[621881172] transaction","detail":"{read_only:false; response_revision:8566; number_of_response:1; }","duration":"173.635991ms","start":"2026-08-14T23:30:26.842873Z","end":"2026-08-14T23:30:27.016509Z","steps":["trace[621881172] 'process raft request' (duration: 145.602161ms)","trace[621881172] 'compare' (duration: 27.680541ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:30:27.016678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.033949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-08-14T23:30:27.016709Z","caller":"traceutil/trace.go:171","msg":"trace[2083537806] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:1; response_revision:8566; }","duration":"104.111941ms","start":"2026-08-14T23:30:26.912589Z","end":"2026-08-14T23:30:27.016701Z","steps":["trace[2083537806] 'agreement among raft nodes before linearized reading' (duration: 103.946937ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:31:14.354305Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002496.wal"} {"level":"info","ts":"2026-08-14T23:32:26.860779Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"50e03cebfd94cbba","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-14T23:32:26.866995Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-14T23:32:26.867086Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-08-14T23:34:53.895157Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8301} {"level":"info","ts":"2026-08-14T23:34:53.968694Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8301,"took":"71.265058ms","hash":751216585,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":26796032,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-08-14T23:34:53.968765Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":751216585,"revision":8301,"compact-revision":6102} {"level":"info","ts":"2026-08-14T23:39:53.901807Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10986} {"level":"info","ts":"2026-08-14T23:39:53.978135Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10986,"took":"73.555227ms","hash":4077123602,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":28131328,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-08-14T23:39:53.978211Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4077123602,"revision":10986,"compact-revision":8301} {"level":"info","ts":"2026-08-14T23:41:30.459554Z","caller":"traceutil/trace.go:171","msg":"trace[1770481970] transaction","detail":"{read_only:false; response_revision:13661; number_of_response:1; }","duration":"106.074707ms","start":"2026-08-14T23:41:30.353457Z","end":"2026-08-14T23:41:30.459532Z","steps":["trace[1770481970] 'process raft request' (duration: 88.292873ms)","trace[1770481970] 'compare' (duration: 17.636441ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:41:30.459551Z","caller":"traceutil/trace.go:171","msg":"trace[2059448978] linearizableReadLoop","detail":"{readStateIndex:14133; appliedIndex:14132; }","duration":"105.677447ms","start":"2026-08-14T23:41:30.353846Z","end":"2026-08-14T23:41:30.459523Z","steps":["trace[2059448978] 'read index received' (duration: 87.902193ms)","trace[2059448978] 'applied index is now lower than readState.Index' (duration: 17.774304ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:41:30.459747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.885852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-14T23:41:30.459799Z","caller":"traceutil/trace.go:171","msg":"trace[1305712098] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:13661; }","duration":"105.974015ms","start":"2026-08-14T23:41:30.353815Z","end":"2026-08-14T23:41:30.459789Z","steps":["trace[1305712098] 'agreement among raft nodes before linearized reading' (duration: 105.759719ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:41:30.459963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.053913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-14T23:41:30.46002Z","caller":"traceutil/trace.go:171","msg":"trace[771134216] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:13661; }","duration":"102.158386ms","start":"2026-08-14T23:41:30.357844Z","end":"2026-08-14T23:41:30.460002Z","steps":["trace[771134216] 'agreement among raft nodes before linearized reading' (duration: 101.94511ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:41:37.366195Z","caller":"traceutil/trace.go:171","msg":"trace[1872625206] transaction","detail":"{read_only:false; response_revision:13711; number_of_response:1; }","duration":"145.218129ms","start":"2026-08-14T23:41:37.220944Z","end":"2026-08-14T23:41:37.366162Z","steps":["trace[1872625206] 'process raft request' (duration: 144.86546ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:41:38.120605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.413472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T23:41:38.120711Z","caller":"traceutil/trace.go:171","msg":"trace[1896157395] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:13715; }","duration":"189.579836ms","start":"2026-08-14T23:41:37.931107Z","end":"2026-08-14T23:41:38.120687Z","steps":["trace[1896157395] 'count revisions from in-memory index tree' (duration: 189.323719ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:42:00.096917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.168826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-08-14T23:42:00.097004Z","caller":"traceutil/trace.go:171","msg":"trace[1135582218] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:14030; }","duration":"268.30381ms","start":"2026-08-14T23:41:59.828681Z","end":"2026-08-14T23:42:00.096985Z","steps":["trace[1135582218] 'range keys from in-memory index tree' (duration: 268.002582ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:42:00.097095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.925178ms","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-08-14T23:42:00.097211Z","caller":"traceutil/trace.go:171","msg":"trace[70219063] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14030; }","duration":"266.093822ms","start":"2026-08-14T23:41:59.831094Z","end":"2026-08-14T23:42:00.097188Z","steps":["trace[70219063] 'range keys from in-memory index tree' (duration: 265.729883ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:44:53.907858Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13028} {"level":"info","ts":"2026-08-14T23:44:53.98376Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13028,"took":"73.106747ms","hash":2715611825,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":30576640,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-14T23:44:53.983833Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2715611825,"revision":13028,"compact-revision":10986} {"level":"info","ts":"2026-08-14T23:48:28.741166Z","caller":"traceutil/trace.go:171","msg":"trace[1475220605] linearizableReadLoop","detail":"{readStateIndex:17776; appliedIndex:17775; }","duration":"134.969451ms","start":"2026-08-14T23:48:28.606163Z","end":"2026-08-14T23:48:28.741133Z","steps":["trace[1475220605] 'read index received' (duration: 113.974824ms)","trace[1475220605] 'applied index is now lower than readState.Index' (duration: 20.993487ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:48:28.741433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.257018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2083"} {"level":"info","ts":"2026-08-14T23:48:28.741607Z","caller":"traceutil/trace.go:171","msg":"trace[1308661514] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:17194; }","duration":"135.482954ms","start":"2026-08-14T23:48:28.606103Z","end":"2026-08-14T23:48:28.741586Z","steps":["trace[1308661514] 'agreement among raft nodes before linearized reading' (duration: 135.146745ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:48:28.741421Z","caller":"traceutil/trace.go:171","msg":"trace[602348374] transaction","detail":"{read_only:false; response_revision:17194; number_of_response:1; }","duration":"150.62478ms","start":"2026-08-14T23:48:28.590762Z","end":"2026-08-14T23:48:28.741386Z","steps":["trace[602348374] 'process raft request' (duration: 129.510299ms)","trace[602348374] 'compare' (duration: 20.605868ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:48:34.535757Z","caller":"traceutil/trace.go:171","msg":"trace[2121095484] transaction","detail":"{read_only:false; response_revision:17223; number_of_response:1; }","duration":"258.702089ms","start":"2026-08-14T23:48:34.277011Z","end":"2026-08-14T23:48:34.535713Z","steps":["trace[2121095484] 'process raft request' (duration: 258.010501ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:48:34.536753Z","caller":"traceutil/trace.go:171","msg":"trace[1990107323] transaction","detail":"{read_only:false; response_revision:17224; number_of_response:1; }","duration":"251.655156ms","start":"2026-08-14T23:48:34.28502Z","end":"2026-08-14T23:48:34.536675Z","steps":["trace[1990107323] 'process raft request' (duration: 251.271176ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:48:34.536909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.408535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-08-14T23:48:34.536991Z","caller":"traceutil/trace.go:171","msg":"trace[746445362] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:17224; }","duration":"247.544718ms","start":"2026-08-14T23:48:34.289431Z","end":"2026-08-14T23:48:34.536976Z","steps":["trace[746445362] 'agreement among raft nodes before linearized reading' (duration: 247.315782ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:48:34.53671Z","caller":"traceutil/trace.go:171","msg":"trace[1746998345] linearizableReadLoop","detail":"{readStateIndex:17807; appliedIndex:17805; }","duration":"246.950143ms","start":"2026-08-14T23:48:34.289496Z","end":"2026-08-14T23:48:34.536446Z","steps":["trace[1746998345] 'read index received' (duration: 245.548846ms)","trace[1746998345] 'applied index is now lower than readState.Index' (duration: 1.399377ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:48:34.537729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.901721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-t685r\" ","response":"range_response_count:1 size:9799"} {"level":"info","ts":"2026-08-14T23:48:34.537765Z","caller":"traceutil/trace.go:171","msg":"trace[1640444140] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-t685r; range_end:; response_count:1; response_revision:17224; }","duration":"208.989273ms","start":"2026-08-14T23:48:34.328766Z","end":"2026-08-14T23:48:34.537755Z","steps":["trace[1640444140] 'agreement among raft nodes before linearized reading' (duration: 208.87674ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:48:34.537907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.506905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-rztdw\" ","response":"range_response_count:1 size:20758"} {"level":"info","ts":"2026-08-14T23:48:34.538008Z","caller":"traceutil/trace.go:171","msg":"trace[1115813158] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-rztdw; range_end:; response_count:1; response_revision:17224; }","duration":"189.655319ms","start":"2026-08-14T23:48:34.348331Z","end":"2026-08-14T23:48:34.537986Z","steps":["trace[1115813158] 'agreement among raft nodes before linearized reading' (duration: 189.357991ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:48:34.680019Z","caller":"traceutil/trace.go:171","msg":"trace[746252060] linearizableReadLoop","detail":"{readStateIndex:17808; appliedIndex:17807; }","duration":"116.016116ms","start":"2026-08-14T23:48:34.563972Z","end":"2026-08-14T23:48:34.679988Z","steps":["trace[746252060] 'read index received' (duration: 82.843331ms)","trace[746252060] 'applied index is now lower than readState.Index' (duration: 33.171555ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:48:34.680433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.440948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-14T23:48:34.68049Z","caller":"traceutil/trace.go:171","msg":"trace[480713654] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17225; }","duration":"116.566461ms","start":"2026-08-14T23:48:34.563913Z","end":"2026-08-14T23:48:34.68048Z","steps":["trace[480713654] 'agreement among raft nodes before linearized reading' (duration: 116.210822ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:48:34.68038Z","caller":"traceutil/trace.go:171","msg":"trace[28750546] transaction","detail":"{read_only:false; response_revision:17225; number_of_response:1; }","duration":"116.418377ms","start":"2026-08-14T23:48:34.563716Z","end":"2026-08-14T23:48:34.680134Z","steps":["trace[28750546] 'process raft request' (duration: 83.071757ms)","trace[28750546] 'compare' (duration: 33.040802ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:48:34.720699Z","caller":"traceutil/trace.go:171","msg":"trace[1020486336] transaction","detail":"{read_only:false; response_revision:17226; number_of_response:1; }","duration":"154.597173ms","start":"2026-08-14T23:48:34.566082Z","end":"2026-08-14T23:48:34.720679Z","steps":["trace[1020486336] 'process raft request' (duration: 154.317346ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:48:34.720786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.3741ms","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-08-14T23:48:34.720977Z","caller":"traceutil/trace.go:171","msg":"trace[932726736] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17226; }","duration":"156.573945ms","start":"2026-08-14T23:48:34.564364Z","end":"2026-08-14T23:48:34.720938Z","steps":["trace[932726736] 'agreement among raft nodes before linearized reading' (duration: 156.215565ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:48:42.718956Z","caller":"traceutil/trace.go:171","msg":"trace[1183419890] linearizableReadLoop","detail":"{readStateIndex:17977; appliedIndex:17974; }","duration":"105.693607ms","start":"2026-08-14T23:48:42.61325Z","end":"2026-08-14T23:48:42.718944Z","steps":["trace[1183419890] 'read index received' (duration: 105.03086ms)","trace[1183419890] 'applied index is now lower than readState.Index' (duration: 662.347µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:48:42.719042Z","caller":"traceutil/trace.go:171","msg":"trace[1196542540] transaction","detail":"{read_only:false; response_revision:17388; number_of_response:1; }","duration":"110.242426ms","start":"2026-08-14T23:48:42.608772Z","end":"2026-08-14T23:48:42.719014Z","steps":["trace[1196542540] 'process raft request' (duration: 110.108563ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:48:42.719125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.226131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:651"} {"level":"info","ts":"2026-08-14T23:48:42.719157Z","caller":"traceutil/trace.go:171","msg":"trace[1545300710] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:17388; }","duration":"101.297773ms","start":"2026-08-14T23:48:42.617851Z","end":"2026-08-14T23:48:42.719148Z","steps":["trace[1545300710] 'agreement among raft nodes before linearized reading' (duration: 101.17462ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:48:42.719188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.690124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/libvirt-libvirt-default-rztdw-vnc-qf4xw\" ","response":"range_response_count:1 size:2537"} {"level":"warn","ts":"2026-08-14T23:48:42.719248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.03595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-14T23:48:42.719266Z","caller":"traceutil/trace.go:171","msg":"trace[1901667113] range","detail":"{range_begin:/registry/secrets/openstack/libvirt-libvirt-default-rztdw-vnc-qf4xw; range_end:; response_count:1; response_revision:17388; }","duration":"116.815397ms","start":"2026-08-14T23:48:42.602435Z","end":"2026-08-14T23:48:42.71925Z","steps":["trace[1901667113] 'agreement among raft nodes before linearized reading' (duration: 116.595762ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:48:42.719286Z","caller":"traceutil/trace.go:171","msg":"trace[592351054] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:17388; }","duration":"100.101511ms","start":"2026-08-14T23:48:42.61917Z","end":"2026-08-14T23:48:42.719272Z","steps":["trace[592351054] 'agreement among raft nodes before linearized reading' (duration: 100.015809ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:48:42.718985Z","caller":"traceutil/trace.go:171","msg":"trace[581909530] transaction","detail":"{read_only:false; response_revision:17387; number_of_response:1; }","duration":"116.51249ms","start":"2026-08-14T23:48:42.602442Z","end":"2026-08-14T23:48:42.718955Z","steps":["trace[581909530] 'process raft request' (duration: 116.278244ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:48:42.718815Z","caller":"traceutil/trace.go:171","msg":"trace[1284254907] transaction","detail":"{read_only:false; response_revision:17386; number_of_response:1; }","duration":"119.312433ms","start":"2026-08-14T23:48:42.599448Z","end":"2026-08-14T23:48:42.718761Z","steps":["trace[1284254907] 'process raft request' (duration: 118.933923ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:48:42.865041Z","caller":"traceutil/trace.go:171","msg":"trace[423510572] linearizableReadLoop","detail":"{readStateIndex:17980; appliedIndex:17979; }","duration":"110.956105ms","start":"2026-08-14T23:48:42.754065Z","end":"2026-08-14T23:48:42.865021Z","steps":["trace[423510572] 'read index received' (duration: 110.915754ms)","trace[423510572] 'applied index is now lower than readState.Index' (duration: 39.381µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:48:42.865221Z","caller":"traceutil/trace.go:171","msg":"trace[1769691358] transaction","detail":"{read_only:false; response_revision:17391; number_of_response:1; }","duration":"112.995218ms","start":"2026-08-14T23:48:42.752215Z","end":"2026-08-14T23:48:42.865211Z","steps":["trace[1769691358] 'process raft request' (duration: 112.662559ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:48:42.865535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.450997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:16 size:111938"} {"level":"info","ts":"2026-08-14T23:48:42.865568Z","caller":"traceutil/trace.go:171","msg":"trace[1179907674] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:16; response_revision:17391; }","duration":"111.51132ms","start":"2026-08-14T23:48:42.754049Z","end":"2026-08-14T23:48:42.86556Z","steps":["trace[1179907674] 'agreement among raft nodes before linearized reading' (duration: 111.271623ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:48:42.867932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.198834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3959"} {"level":"info","ts":"2026-08-14T23:48:42.86803Z","caller":"traceutil/trace.go:171","msg":"trace[38119143] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:17392; }","duration":"113.314406ms","start":"2026-08-14T23:48:42.754691Z","end":"2026-08-14T23:48:42.868005Z","steps":["trace[38119143] 'agreement among raft nodes before linearized reading' (duration: 113.06025ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:48:42.868444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.926926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-14T23:48:42.86849Z","caller":"traceutil/trace.go:171","msg":"trace[130063564] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17392; }","duration":"107.983037ms","start":"2026-08-14T23:48:42.760495Z","end":"2026-08-14T23:48:42.868478Z","steps":["trace[130063564] 'agreement among raft nodes before linearized reading' (duration: 107.893444ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:48:42.868615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.634196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1822"} {"level":"info","ts":"2026-08-14T23:48:42.868649Z","caller":"traceutil/trace.go:171","msg":"trace[474824516] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:17392; }","duration":"110.687308ms","start":"2026-08-14T23:48:42.757952Z","end":"2026-08-14T23:48:42.86864Z","steps":["trace[474824516] 'agreement among raft nodes before linearized reading' (duration: 110.603016ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:49:53.918623Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15416} {"level":"info","ts":"2026-08-14T23:49:54.015228Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15416,"took":"93.940622ms","hash":1885892674,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":33984512,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-14T23:49:54.015308Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1885892674,"revision":15416,"compact-revision":13028} {"level":"info","ts":"2026-08-14T23:52:40.087754Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"50e03cebfd94cbba","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-14T23:52:40.093188Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-08-14T23:52:40.093258Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-08-14T23:53:59.187203Z","caller":"traceutil/trace.go:171","msg":"trace[832853626] transaction","detail":"{read_only:false; response_revision:19788; number_of_response:1; }","duration":"154.912001ms","start":"2026-08-14T23:53:59.032263Z","end":"2026-08-14T23:53:59.187175Z","steps":["trace[832853626] 'process raft request' (duration: 154.615023ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:53:59.365056Z","caller":"traceutil/trace.go:171","msg":"trace[706770334] transaction","detail":"{read_only:false; response_revision:19789; number_of_response:1; }","duration":"216.363052ms","start":"2026-08-14T23:53:59.148668Z","end":"2026-08-14T23:53:59.365031Z","steps":["trace[706770334] 'process raft request' (duration: 191.062369ms)","trace[706770334] 'compare' (duration: 25.19111ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:54:00.097148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.892793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"warn","ts":"2026-08-14T23:54:00.097212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.429386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-08-14T23:54:00.097241Z","caller":"traceutil/trace.go:171","msg":"trace[444041184] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:19790; }","duration":"128.038087ms","start":"2026-08-14T23:53:59.969184Z","end":"2026-08-14T23:54:00.097222Z","steps":["trace[444041184] 'range keys from in-memory index tree' (duration: 127.718478ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:54:00.097267Z","caller":"traceutil/trace.go:171","msg":"trace[449944251] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:19790; }","duration":"152.528759ms","start":"2026-08-14T23:53:59.944725Z","end":"2026-08-14T23:54:00.097254Z","steps":["trace[449944251] 'range keys from in-memory index tree' (duration: 152.271572ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:54:00.385761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.963933ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-14T23:54:00.385882Z","caller":"traceutil/trace.go:171","msg":"trace[715180813] transaction","detail":"{read_only:false; response_revision:19792; number_of_response:1; }","duration":"284.130909ms","start":"2026-08-14T23:54:00.101731Z","end":"2026-08-14T23:54:00.385862Z","steps":["trace[715180813] 'process raft request' (duration: 128.753116ms)","trace[715180813] 'compare' (duration: 154.397557ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:54:00.425993Z","caller":"traceutil/trace.go:171","msg":"trace[1832867955] transaction","detail":"{read_only:false; response_revision:19793; number_of_response:1; }","duration":"323.814619ms","start":"2026-08-14T23:54:00.102146Z","end":"2026-08-14T23:54:00.42596Z","steps":["trace[1832867955] 'process raft request' (duration: 323.625684ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:54:00.426105Z","caller":"traceutil/trace.go:171","msg":"trace[259215560] linearizableReadLoop","detail":"{readStateIndex:20459; appliedIndex:20458; }","duration":"178.226342ms","start":"2026-08-14T23:54:00.247854Z","end":"2026-08-14T23:54:00.42608Z","steps":["trace[259215560] 'read index received' (duration: 177.913044ms)","trace[259215560] 'applied index is now lower than readState.Index' (duration: 309.828µs)"],"step_count":2} {"level":"warn","ts":"2026-08-14T23:54:00.426262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T23:54:00.102132Z","time spent":"323.946652ms","remote":"127.0.0.1:44626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T23:54:00.426276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.401056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-14T23:54:00.426371Z","caller":"traceutil/trace.go:171","msg":"trace[2089443041] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:19793; }","duration":"178.53946ms","start":"2026-08-14T23:54:00.247804Z","end":"2026-08-14T23:54:00.426343Z","steps":["trace[2089443041] 'agreement among raft nodes before linearized reading' (duration: 178.373186ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:54:00.426401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.074937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-08-14T23:54:00.426442Z","caller":"traceutil/trace.go:171","msg":"trace[869547888] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:19793; }","duration":"115.166309ms","start":"2026-08-14T23:54:00.311263Z","end":"2026-08-14T23:54:00.426429Z","steps":["trace[869547888] 'agreement among raft nodes before linearized reading' (duration: 114.966984ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:54:00.427348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.319505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-08-14T23:54:00.427404Z","caller":"traceutil/trace.go:171","msg":"trace[697046506] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:19793; }","duration":"112.422818ms","start":"2026-08-14T23:54:00.314968Z","end":"2026-08-14T23:54:00.427391Z","steps":["trace[697046506] 'agreement among raft nodes before linearized reading' (duration: 111.338029ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:54:00.427727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.963109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-08-14T23:54:00.427799Z","caller":"traceutil/trace.go:171","msg":"trace[1462767981] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:19793; }","duration":"111.038611ms","start":"2026-08-14T23:54:00.316726Z","end":"2026-08-14T23:54:00.427765Z","steps":["trace[1462767981] 'agreement among raft nodes before linearized reading' (duration: 110.882347ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:54:53.929374Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":18056} {"level":"info","ts":"2026-08-14T23:54:54.145227Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":18056,"took":"212.113861ms","hash":3544857405,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":30609408,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-14T23:54:54.145286Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3544857405,"revision":18056,"compact-revision":15416} {"level":"info","ts":"2026-08-14T23:57:38.662781Z","caller":"traceutil/trace.go:171","msg":"trace[1111250762] linearizableReadLoop","detail":"{readStateIndex:22910; appliedIndex:22909; }","duration":"217.628952ms","start":"2026-08-14T23:57:38.445121Z","end":"2026-08-14T23:57:38.66275Z","steps":["trace[1111250762] 'read index received' (duration: 217.5517ms)","trace[1111250762] 'applied index is now lower than readState.Index' (duration: 75.672µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T23:57:38.662865Z","caller":"traceutil/trace.go:171","msg":"trace[1305148400] transaction","detail":"{read_only:false; response_revision:22174; number_of_response:1; }","duration":"226.251137ms","start":"2026-08-14T23:57:38.436574Z","end":"2026-08-14T23:57:38.662825Z","steps":["trace[1305148400] 'process raft request' (duration: 225.971529ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:57:38.663153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.004931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-14T23:57:38.663221Z","caller":"traceutil/trace.go:171","msg":"trace[1116019552] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:22174; }","duration":"218.147735ms","start":"2026-08-14T23:57:38.445059Z","end":"2026-08-14T23:57:38.663206Z","steps":["trace[1116019552] 'agreement among raft nodes before linearized reading' (duration: 217.99063ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T23:57:38.663903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.847468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-14T23:57:38.664045Z","caller":"traceutil/trace.go:171","msg":"trace[869873381] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22175; }","duration":"120.044714ms","start":"2026-08-14T23:57:38.543968Z","end":"2026-08-14T23:57:38.664012Z","steps":["trace[869873381] 'agreement among raft nodes before linearized reading' (duration: 119.805857ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T23:59:53.937089Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20333} {"level":"info","ts":"2026-08-14T23:59:54.044514Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20333,"took":"103.616675ms","hash":2412802621,"current-db-size-bytes":59953152,"current-db-size":"60 MB","current-db-size-in-use-bytes":43352064,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-08-14T23:59:54.044591Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2412802621,"revision":20333,"compact-revision":18056} {"level":"info","ts":"2026-08-15T00:04:53.94722Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23442} {"level":"info","ts":"2026-08-15T00:04:54.098995Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23442,"took":"142.369616ms","hash":1904088855,"current-db-size-bytes":59953152,"current-db-size":"60 MB","current-db-size-in-use-bytes":30846976,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-15T00:04:54.099055Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1904088855,"revision":23442,"compact-revision":20333}