{"level":"warn","ts":"2026-04-19T13:31:11.267982Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-19T13:31:11.268075Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.49: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.49:2380","--initial-cluster=instance=https://199.204.45.49:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.49:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.49:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-19T13:31:11.268147Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-19T13:31:11.26816Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.49:2380"]} {"level":"info","ts":"2026-04-19T13:31:11.268182Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-19T13:31:11.268878Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"]} {"level":"info","ts":"2026-04-19T13:31:11.268952Z","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.49:2380"],"listen-peer-urls":["https://199.204.45.49:2380"],"advertise-client-urls":["https://199.204.45.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.49:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-19T13:31:11.272685Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.534508ms"} {"level":"info","ts":"2026-04-19T13:31:11.279267Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d0ba3c4de8c6ef7a","cluster-id":"e76701b877f442ac"} {"level":"info","ts":"2026-04-19T13:31:11.279354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=()"} {"level":"info","ts":"2026-04-19T13:31:11.279379Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became follower at term 0"} {"level":"info","ts":"2026-04-19T13:31:11.279399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d0ba3c4de8c6ef7a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-19T13:31:11.279416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became follower at term 1"} {"level":"info","ts":"2026-04-19T13:31:11.279461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=(15040400210872692602)"} {"level":"warn","ts":"2026-04-19T13:31:11.287092Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-19T13:31:11.289391Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-19T13:31:11.290682Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-19T13:31:11.292725Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d0ba3c4de8c6ef7a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-19T13:31:11.292928Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d0ba3c4de8c6ef7a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-19T13:31:11.293018Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-19T13:31:11.293168Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-19T13:31:11.293187Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-19T13:31:11.295532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=(15040400210872692602)"} {"level":"info","ts":"2026-04-19T13:31:11.295664Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e76701b877f442ac","local-member-id":"d0ba3c4de8c6ef7a","added-peer-id":"d0ba3c4de8c6ef7a","added-peer-peer-urls":["https://199.204.45.49:2380"]} {"level":"info","ts":"2026-04-19T13:31:11.297146Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-19T13:31:11.297323Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.49:2380"} {"level":"info","ts":"2026-04-19T13:31:11.297425Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.49:2380"} {"level":"info","ts":"2026-04-19T13:31:11.297641Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d0ba3c4de8c6ef7a","initial-advertise-peer-urls":["https://199.204.45.49:2380"],"listen-peer-urls":["https://199.204.45.49:2380"],"advertise-client-urls":["https://199.204.45.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-19T13:31:11.297723Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-19T13:31:11.980304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a is starting a new election at term 1"} {"level":"info","ts":"2026-04-19T13:31:11.980361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became pre-candidate at term 1"} {"level":"info","ts":"2026-04-19T13:31:11.980396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a received MsgPreVoteResp from d0ba3c4de8c6ef7a at term 1"} {"level":"info","ts":"2026-04-19T13:31:11.980416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became candidate at term 2"} {"level":"info","ts":"2026-04-19T13:31:11.980427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a received MsgVoteResp from d0ba3c4de8c6ef7a at term 2"} {"level":"info","ts":"2026-04-19T13:31:11.980467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became leader at term 2"} {"level":"info","ts":"2026-04-19T13:31:11.980482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d0ba3c4de8c6ef7a elected leader d0ba3c4de8c6ef7a at term 2"} {"level":"info","ts":"2026-04-19T13:31:11.982664Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d0ba3c4de8c6ef7a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.49:2379]}","request-path":"/0/members/d0ba3c4de8c6ef7a/attributes","cluster-id":"e76701b877f442ac","publish-timeout":"7s"} {"level":"info","ts":"2026-04-19T13:31:11.982814Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-19T13:31:11.982894Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-19T13:31:11.982906Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-19T13:31:11.983756Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e76701b877f442ac","local-member-id":"d0ba3c4de8c6ef7a","cluster-version":"3.5"} {"level":"info","ts":"2026-04-19T13:31:11.983821Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-19T13:31:11.983836Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-19T13:31:11.9858Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.49:2379"} {"level":"info","ts":"2026-04-19T13:31:11.985907Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-19T13:31:11.991955Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-19T13:31:11.992032Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-19T13:31:41.649945Z","caller":"traceutil/trace.go:171","msg":"trace[1053678311] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"210.087309ms","start":"2026-04-19T13:31:41.439832Z","end":"2026-04-19T13:31:41.649919Z","steps":["trace[1053678311] 'process raft request' (duration: 209.262082ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:41.695295Z","caller":"traceutil/trace.go:171","msg":"trace[314059911] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"202.662128ms","start":"2026-04-19T13:31:41.492609Z","end":"2026-04-19T13:31:41.695272Z","steps":["trace[314059911] 'process raft request' (duration: 202.483575ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:46.456635Z","caller":"traceutil/trace.go:171","msg":"trace[1746911541] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"120.929337ms","start":"2026-04-19T13:31:46.335678Z","end":"2026-04-19T13:31:46.456607Z","steps":["trace[1746911541] 'process raft request' (duration: 120.815315ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:46.676168Z","caller":"traceutil/trace.go:171","msg":"trace[1390629844] linearizableReadLoop","detail":"{readStateIndex:589; appliedIndex:588; }","duration":"150.38437ms","start":"2026-04-19T13:31:46.525756Z","end":"2026-04-19T13:31:46.676141Z","steps":["trace[1390629844] 'read index received' (duration: 149.599356ms)","trace[1390629844] 'applied index is now lower than readState.Index' (duration: 783.914µs)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:31:46.676252Z","caller":"traceutil/trace.go:171","msg":"trace[1089785336] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"258.252168ms","start":"2026-04-19T13:31:46.417962Z","end":"2026-04-19T13:31:46.676214Z","steps":["trace[1089785336] 'process raft request' (duration: 257.660927ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:46.676397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.631915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-19T13:31:46.676492Z","caller":"traceutil/trace.go:171","msg":"trace[2023327868] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:570; }","duration":"150.788088ms","start":"2026-04-19T13:31:46.525692Z","end":"2026-04-19T13:31:46.67648Z","steps":["trace[2023327868] 'agreement among raft nodes before linearized reading' (duration: 150.584284ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:47.313836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.165673ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-19T13:31:47.313957Z","caller":"traceutil/trace.go:171","msg":"trace[1026888956] linearizableReadLoop","detail":"{readStateIndex:591; appliedIndex:590; }","duration":"547.996418ms","start":"2026-04-19T13:31:46.765936Z","end":"2026-04-19T13:31:47.313933Z","steps":["trace[1026888956] 'read index received' (duration: 78.188592ms)","trace[1026888956] 'applied index is now lower than readState.Index' (duration: 469.805626ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:31:47.314005Z","caller":"traceutil/trace.go:171","msg":"trace[835468689] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"579.236754ms","start":"2026-04-19T13:31:46.734707Z","end":"2026-04-19T13:31:47.313944Z","steps":["trace[835468689] 'process raft request' (duration: 109.48462ms)","trace[835468689] 'compare' (duration: 469.02026ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:31:47.314119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:46.734681Z","time spent":"579.390067ms","remote":"127.0.0.1:46740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-19T13:31:47.314176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.248653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kpzw5\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-19T13:31:47.314209Z","caller":"traceutil/trace.go:171","msg":"trace[1177610101] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kpzw5; range_end:; response_count:1; response_revision:572; }","duration":"548.314074ms","start":"2026-04-19T13:31:46.765886Z","end":"2026-04-19T13:31:47.3142Z","steps":["trace[1177610101] 'agreement among raft nodes before linearized reading' (duration: 548.11113ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:47.314241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:46.765871Z","time spent":"548.363095ms","remote":"127.0.0.1:46432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-kpzw5\" "} {"level":"warn","ts":"2026-04-19T13:32:01.979067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.961906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T13:32:01.979199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.5003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4nf75\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-04-19T13:32:01.979268Z","caller":"traceutil/trace.go:171","msg":"trace[1523680972] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4nf75; range_end:; response_count:1; response_revision:728; }","duration":"118.570821ms","start":"2026-04-19T13:32:01.860679Z","end":"2026-04-19T13:32:01.97925Z","steps":["trace[1523680972] 'range keys from in-memory index tree' (duration: 118.275017ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:32:01.979279Z","caller":"traceutil/trace.go:171","msg":"trace[147735107] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:728; }","duration":"260.200922ms","start":"2026-04-19T13:32:01.719026Z","end":"2026-04-19T13:32:01.979227Z","steps":["trace[147735107] 'range keys from in-memory index tree' (duration: 259.864125ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:32:28.803089Z","caller":"traceutil/trace.go:171","msg":"trace[234195803] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"136.132667ms","start":"2026-04-19T13:32:28.666929Z","end":"2026-04-19T13:32:28.803062Z","steps":["trace[234195803] 'process raft request' (duration: 135.975744ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:33:13.550687Z","caller":"traceutil/trace.go:171","msg":"trace[539041409] transaction","detail":"{read_only:false; response_revision:1775; number_of_response:1; }","duration":"102.814512ms","start":"2026-04-19T13:33:13.447847Z","end":"2026-04-19T13:33:13.550662Z","steps":["trace[539041409] 'process raft request' (duration: 102.661349ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:33:13.576483Z","caller":"traceutil/trace.go:171","msg":"trace[1028117076] transaction","detail":"{read_only:false; response_revision:1776; number_of_response:1; }","duration":"105.303871ms","start":"2026-04-19T13:33:13.471114Z","end":"2026-04-19T13:33:13.576418Z","steps":["trace[1028117076] 'process raft request' (duration: 105.190569ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:33:27.437011Z","caller":"traceutil/trace.go:171","msg":"trace[1739131912] linearizableReadLoop","detail":"{readStateIndex:1961; appliedIndex:1960; }","duration":"277.730582ms","start":"2026-04-19T13:33:27.159254Z","end":"2026-04-19T13:33:27.436985Z","steps":["trace[1739131912] 'read index received' (duration: 276.310745ms)","trace[1739131912] 'applied index is now lower than readState.Index' (duration: 1.418397ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:33:27.437126Z","caller":"traceutil/trace.go:171","msg":"trace[2019426416] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"348.536143ms","start":"2026-04-19T13:33:27.08855Z","end":"2026-04-19T13:33:27.437086Z","steps":["trace[2019426416] 'process raft request' (duration: 347.005144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:33:27.437307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.047208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-19T13:33:27.437358Z","caller":"traceutil/trace.go:171","msg":"trace[1376978204] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1891; }","duration":"278.16687ms","start":"2026-04-19T13:33:27.15918Z","end":"2026-04-19T13:33:27.437347Z","steps":["trace[1376978204] 'agreement among raft nodes before linearized reading' (duration: 277.972296ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:33:27.43743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:33:27.088539Z","time spent":"348.639966ms","remote":"127.0.0.1:46500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T13:33:27.437842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.223199ms","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-04-19T13:33:27.437927Z","caller":"traceutil/trace.go:171","msg":"trace[1178886493] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1891; }","duration":"226.315521ms","start":"2026-04-19T13:33:27.21158Z","end":"2026-04-19T13:33:27.437895Z","steps":["trace[1178886493] 'agreement among raft nodes before linearized reading' (duration: 226.131008ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:34:03.763652Z","caller":"traceutil/trace.go:171","msg":"trace[810820727] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"113.880796ms","start":"2026-04-19T13:34:03.649726Z","end":"2026-04-19T13:34:03.763607Z","steps":["trace[810820727] 'process raft request' (duration: 103.390666ms)","trace[810820727] 'compare' (duration: 10.310817ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:34:03.763766Z","caller":"traceutil/trace.go:171","msg":"trace[339114750] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"113.288146ms","start":"2026-04-19T13:34:03.650467Z","end":"2026-04-19T13:34:03.763755Z","steps":["trace[339114750] 'process raft request' (duration: 113.076912ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:34:09.329024Z","caller":"traceutil/trace.go:171","msg":"trace[240605204] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"135.066409ms","start":"2026-04-19T13:34:09.193915Z","end":"2026-04-19T13:34:09.328981Z","steps":["trace[240605204] 'process raft request' (duration: 134.815143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:34:09.507273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.223993ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:34:09.507469Z","caller":"traceutil/trace.go:171","msg":"trace[711609589] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2132; }","duration":"133.458897ms","start":"2026-04-19T13:34:09.373984Z","end":"2026-04-19T13:34:09.507443Z","steps":["trace[711609589] 'range keys from in-memory index tree' (duration: 133.190902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:35:30.352197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.046764ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-19T13:35:30.352308Z","caller":"traceutil/trace.go:171","msg":"trace[1498443914] linearizableReadLoop","detail":"{readStateIndex:2866; appliedIndex:2865; }","duration":"146.758109ms","start":"2026-04-19T13:35:30.205534Z","end":"2026-04-19T13:35:30.352292Z","steps":["trace[1498443914] 'read index received' (duration: 10.179045ms)","trace[1498443914] 'applied index is now lower than readState.Index' (duration: 136.577904ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:35:30.352355Z","caller":"traceutil/trace.go:171","msg":"trace[790148982] transaction","detail":"{read_only:false; response_revision:2763; number_of_response:1; }","duration":"154.11731ms","start":"2026-04-19T13:35:30.1982Z","end":"2026-04-19T13:35:30.352318Z","steps":["trace[790148982] 'process raft request' (duration: 17.560446ms)","trace[790148982] 'compare' (duration: 135.875091ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:35:30.352486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.947063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-04-19T13:35:30.352524Z","caller":"traceutil/trace.go:171","msg":"trace[343613687] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2763; }","duration":"146.995993ms","start":"2026-04-19T13:35:30.205519Z","end":"2026-04-19T13:35:30.352515Z","steps":["trace[343613687] 'agreement among raft nodes before linearized reading' (duration: 146.81644ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:37:56.170256Z","caller":"traceutil/trace.go:171","msg":"trace[407802984] transaction","detail":"{read_only:false; response_revision:3733; number_of_response:1; }","duration":"153.682848ms","start":"2026-04-19T13:37:56.016554Z","end":"2026-04-19T13:37:56.170237Z","steps":["trace[407802984] 'process raft request' (duration: 153.542345ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:37:56.170389Z","caller":"traceutil/trace.go:171","msg":"trace[1508619420] linearizableReadLoop","detail":"{readStateIndex:3873; appliedIndex:3872; }","duration":"129.241489ms","start":"2026-04-19T13:37:56.040965Z","end":"2026-04-19T13:37:56.170207Z","steps":["trace[1508619420] 'read index received' (duration: 129.084996ms)","trace[1508619420] 'applied index is now lower than readState.Index' (duration: 155.913µs)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:37:56.170548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.581285ms","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-04-19T13:37:56.170611Z","caller":"traceutil/trace.go:171","msg":"trace[1923776486] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3733; }","duration":"129.677757ms","start":"2026-04-19T13:37:56.04092Z","end":"2026-04-19T13:37:56.170597Z","steps":["trace[1923776486] 'agreement among raft nodes before linearized reading' (duration: 129.435453ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:37:56.283871Z","caller":"traceutil/trace.go:171","msg":"trace[1324030783] linearizableReadLoop","detail":"{readStateIndex:3874; appliedIndex:3873; }","duration":"109.978659ms","start":"2026-04-19T13:37:56.173874Z","end":"2026-04-19T13:37:56.283852Z","steps":["trace[1324030783] 'read index received' (duration: 109.849507ms)","trace[1324030783] 'applied index is now lower than readState.Index' (duration: 128.412µs)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:37:56.284093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.203873ms","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-04-19T13:37:56.284143Z","caller":"traceutil/trace.go:171","msg":"trace[101211796] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3734; }","duration":"110.287866ms","start":"2026-04-19T13:37:56.173842Z","end":"2026-04-19T13:37:56.28413Z","steps":["trace[101211796] 'agreement among raft nodes before linearized reading' (duration: 110.090712ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:37:56.284412Z","caller":"traceutil/trace.go:171","msg":"trace[687138402] transaction","detail":"{read_only:false; response_revision:3734; number_of_response:1; }","duration":"130.175478ms","start":"2026-04-19T13:37:56.154227Z","end":"2026-04-19T13:37:56.284403Z","steps":["trace[687138402] 'process raft request' (duration: 129.503264ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:39:11.096216Z","caller":"traceutil/trace.go:171","msg":"trace[1780831312] linearizableReadLoop","detail":"{readStateIndex:4788; appliedIndex:4786; }","duration":"132.271976ms","start":"2026-04-19T13:39:10.963918Z","end":"2026-04-19T13:39:11.09619Z","steps":["trace[1780831312] 'read index received' (duration: 69.578028ms)","trace[1780831312] 'applied index is now lower than readState.Index' (duration: 62.692758ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:39:11.096333Z","caller":"traceutil/trace.go:171","msg":"trace[376017258] transaction","detail":"{read_only:false; response_revision:4611; number_of_response:1; }","duration":"134.362856ms","start":"2026-04-19T13:39:10.961959Z","end":"2026-04-19T13:39:11.096322Z","steps":["trace[376017258] 'process raft request' (duration: 133.982649ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:39:11.096658Z","caller":"traceutil/trace.go:171","msg":"trace[256966625] transaction","detail":"{read_only:false; response_revision:4612; number_of_response:1; }","duration":"130.697625ms","start":"2026-04-19T13:39:10.965854Z","end":"2026-04-19T13:39:11.096552Z","steps":["trace[256966625] 'process raft request' (duration: 130.257647ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:39:11.096912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.957378ms","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:650"} {"level":"info","ts":"2026-04-19T13:39:11.097031Z","caller":"traceutil/trace.go:171","msg":"trace[1640392341] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4612; }","duration":"133.128012ms","start":"2026-04-19T13:39:10.963868Z","end":"2026-04-19T13:39:11.096996Z","steps":["trace[1640392341] 'agreement among raft nodes before linearized reading' (duration: 132.741204ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:39:16.523272Z","caller":"traceutil/trace.go:171","msg":"trace[1492900456] linearizableReadLoop","detail":"{readStateIndex:4945; appliedIndex:4944; }","duration":"162.991518ms","start":"2026-04-19T13:39:16.360261Z","end":"2026-04-19T13:39:16.523252Z","steps":["trace[1492900456] 'read index received' (duration: 162.839295ms)","trace[1492900456] 'applied index is now lower than readState.Index' (duration: 150.663µs)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:39:16.523496Z","caller":"traceutil/trace.go:171","msg":"trace[751598197] transaction","detail":"{read_only:false; response_revision:4762; number_of_response:1; }","duration":"173.629229ms","start":"2026-04-19T13:39:16.349854Z","end":"2026-04-19T13:39:16.523483Z","steps":["trace[751598197] 'process raft request' (duration: 173.245672ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:39:16.523992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.719173ms","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:2082"} {"level":"info","ts":"2026-04-19T13:39:16.524042Z","caller":"traceutil/trace.go:171","msg":"trace[876309460] 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:4762; }","duration":"163.813104ms","start":"2026-04-19T13:39:16.360207Z","end":"2026-04-19T13:39:16.52402Z","steps":["trace[876309460] 'agreement among raft nodes before linearized reading' (duration: 163.702712ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:39:20.398274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.157217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9d459aa0-9fe5-4098-935a-d87e5178750b\" ","response":"range_response_count:1 size:3600"} {"level":"warn","ts":"2026-04-19T13:39:20.398394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.705114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"info","ts":"2026-04-19T13:39:20.398429Z","caller":"traceutil/trace.go:171","msg":"trace[2074094992] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9d459aa0-9fe5-4098-935a-d87e5178750b; range_end:; response_count:1; response_revision:4914; }","duration":"110.341811ms","start":"2026-04-19T13:39:20.288048Z","end":"2026-04-19T13:39:20.39839Z","steps":["trace[2074094992] 'range keys from in-memory index tree' (duration: 109.964034ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:39:20.398475Z","caller":"traceutil/trace.go:171","msg":"trace[1375675758] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:4914; }","duration":"124.851915ms","start":"2026-04-19T13:39:20.273603Z","end":"2026-04-19T13:39:20.398455Z","steps":["trace[1375675758] 'range keys from in-memory index tree' (duration: 124.494549ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:39:20.398827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.318883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:777430"} {"level":"info","ts":"2026-04-19T13:39:20.398932Z","caller":"traceutil/trace.go:171","msg":"trace[168146731] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:4914; }","duration":"155.441056ms","start":"2026-04-19T13:39:20.243449Z","end":"2026-04-19T13:39:20.39889Z","steps":["trace[168146731] 'range keys from in-memory index tree' (duration: 154.783504ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:39:20.490902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.039622ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"warn","ts":"2026-04-19T13:39:38.452064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.041259ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-19T13:39:38.452433Z","caller":"traceutil/trace.go:171","msg":"trace[1629543781] linearizableReadLoop","detail":"{readStateIndex:5472; appliedIndex:5468; }","duration":"232.453982ms","start":"2026-04-19T13:39:38.219956Z","end":"2026-04-19T13:39:38.45241Z","steps":["trace[1629543781] 'read index received' (duration: 69.985125ms)","trace[1629543781] 'applied index is now lower than readState.Index' (duration: 162.467737ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:39:38.452502Z","caller":"traceutil/trace.go:171","msg":"trace[1809244971] transaction","detail":"{read_only:false; response_revision:5276; number_of_response:1; }","duration":"237.281294ms","start":"2026-04-19T13:39:38.215188Z","end":"2026-04-19T13:39:38.452469Z","steps":["trace[1809244971] 'process raft request' (duration: 237.001868ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:39:38.452601Z","caller":"traceutil/trace.go:171","msg":"trace[1966904968] transaction","detail":"{read_only:false; response_revision:5277; number_of_response:1; }","duration":"237.298044ms","start":"2026-04-19T13:39:38.215281Z","end":"2026-04-19T13:39:38.452579Z","steps":["trace[1966904968] 'process raft request' (duration: 237.014298ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:39:38.452748Z","caller":"traceutil/trace.go:171","msg":"trace[1615700560] transaction","detail":"{read_only:false; response_revision:5278; number_of_response:1; }","duration":"237.180232ms","start":"2026-04-19T13:39:38.2155Z","end":"2026-04-19T13:39:38.452681Z","steps":["trace[1615700560] 'process raft request' (duration: 236.871486ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:39:38.452819Z","caller":"traceutil/trace.go:171","msg":"trace[903207888] transaction","detail":"{read_only:false; response_revision:5275; number_of_response:1; }","duration":"238.172031ms","start":"2026-04-19T13:39:38.214632Z","end":"2026-04-19T13:39:38.452804Z","steps":["trace[903207888] 'process raft request' (duration: 75.292665ms)","trace[903207888] 'compare' (duration: 161.879536ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:39:38.453058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.083495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-04-19T13:39:38.453116Z","caller":"traceutil/trace.go:171","msg":"trace[313595143] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:5278; }","duration":"233.166166ms","start":"2026-04-19T13:39:38.219932Z","end":"2026-04-19T13:39:38.453098Z","steps":["trace[313595143] 'agreement among raft nodes before linearized reading' (duration: 232.937312ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:39:38.512667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.054916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0c7bf28a-e2a8-4978-a8f8-82424b4ac626\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-04-19T13:39:38.51276Z","caller":"traceutil/trace.go:171","msg":"trace[624667179] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0c7bf28a-e2a8-4978-a8f8-82424b4ac626; range_end:; response_count:1; response_revision:5279; }","duration":"109.186568ms","start":"2026-04-19T13:39:38.403547Z","end":"2026-04-19T13:39:38.512733Z","steps":["trace[624667179] 'agreement among raft nodes before linearized reading' (duration: 108.964994ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:39:38.512909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.330693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0c7bf28a-e2a8-4978-a8f8-82424b4ac626\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-04-19T13:39:38.513019Z","caller":"traceutil/trace.go:171","msg":"trace[1030320075] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0c7bf28a-e2a8-4978-a8f8-82424b4ac626; range_end:; response_count:1; response_revision:5279; }","duration":"286.471806ms","start":"2026-04-19T13:39:38.226521Z","end":"2026-04-19T13:39:38.512993Z","steps":["trace[1030320075] 'agreement among raft nodes before linearized reading' (duration: 286.075168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:39:38.512907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.164759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:39:38.513133Z","caller":"traceutil/trace.go:171","msg":"trace[1668783299] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5279; }","duration":"268.428875ms","start":"2026-04-19T13:39:38.244682Z","end":"2026-04-19T13:39:38.513111Z","steps":["trace[1668783299] 'agreement among raft nodes before linearized reading' (duration: 268.134189ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:39:38.51322Z","caller":"traceutil/trace.go:171","msg":"trace[334897480] transaction","detail":"{read_only:false; response_revision:5279; number_of_response:1; }","duration":"283.429689ms","start":"2026-04-19T13:39:38.229518Z","end":"2026-04-19T13:39:38.512947Z","steps":["trace[334897480] 'process raft request' (duration: 282.774327ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:39:38.513534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.531353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2210982"} {"level":"info","ts":"2026-04-19T13:39:38.513635Z","caller":"traceutil/trace.go:171","msg":"trace[1139336096] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:5279; }","duration":"101.664195ms","start":"2026-04-19T13:39:38.411949Z","end":"2026-04-19T13:39:38.513614Z","steps":["trace[1139336096] 'agreement among raft nodes before linearized reading' (duration: 100.537984ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:39:38.825334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.285748ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-19T13:39:38.825558Z","caller":"traceutil/trace.go:171","msg":"trace[837456854] transaction","detail":"{read_only:false; response_revision:5280; number_of_response:1; }","duration":"305.470876ms","start":"2026-04-19T13:39:38.520028Z","end":"2026-04-19T13:39:38.825499Z","steps":["trace[837456854] 'process raft request' (duration: 71.938112ms)","trace[837456854] 'compare' (duration: 233.150326ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:39:38.82572Z","caller":"traceutil/trace.go:171","msg":"trace[440933134] transaction","detail":"{read_only:false; response_revision:5285; number_of_response:1; }","duration":"164.465006ms","start":"2026-04-19T13:39:38.661237Z","end":"2026-04-19T13:39:38.825702Z","steps":["trace[440933134] 'process raft request' (duration: 164.426905ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:39:38.825857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:39:38.520013Z","time spent":"305.641009ms","remote":"127.0.0.1:46330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":909,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-19T13:39:38.825874Z","caller":"traceutil/trace.go:171","msg":"trace[242754786] transaction","detail":"{read_only:false; response_revision:5282; number_of_response:1; }","duration":"303.688143ms","start":"2026-04-19T13:39:38.522125Z","end":"2026-04-19T13:39:38.825813Z","steps":["trace[242754786] 'process raft request' (duration: 303.372047ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:39:38.825884Z","caller":"traceutil/trace.go:171","msg":"trace[1896709318] transaction","detail":"{read_only:false; response_revision:5283; number_of_response:1; }","duration":"296.673049ms","start":"2026-04-19T13:39:38.529172Z","end":"2026-04-19T13:39:38.825845Z","steps":["trace[1896709318] 'process raft request' (duration: 296.391364ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:39:38.825987Z","caller":"traceutil/trace.go:171","msg":"trace[536635047] transaction","detail":"{read_only:false; response_revision:5284; number_of_response:1; }","duration":"225.94183ms","start":"2026-04-19T13:39:38.600001Z","end":"2026-04-19T13:39:38.825943Z","steps":["trace[536635047] 'process raft request' (duration: 225.621524ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:39:38.826082Z","caller":"traceutil/trace.go:171","msg":"trace[754735709] linearizableReadLoop","detail":"{readStateIndex:5474; appliedIndex:5473; }","duration":"305.664449ms","start":"2026-04-19T13:39:38.520406Z","end":"2026-04-19T13:39:38.82607Z","steps":["trace[754735709] 'read index received' (duration: 71.571295ms)","trace[754735709] 'applied index is now lower than readState.Index' (duration: 234.091734ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:39:38.826075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:39:38.522113Z","time spent":"303.842835ms","remote":"127.0.0.1:46432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3747,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T13:39:38.825997Z","caller":"traceutil/trace.go:171","msg":"trace[728516013] transaction","detail":"{read_only:false; response_revision:5281; number_of_response:1; }","duration":"305.401034ms","start":"2026-04-19T13:39:38.520567Z","end":"2026-04-19T13:39:38.825968Z","steps":["trace[728516013] 'process raft request' (duration: 304.886255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:39:38.826295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:39:38.520557Z","time spent":"305.662699ms","remote":"127.0.0.1:46330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":902,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-19T13:39:38.826426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.007296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"warn","ts":"2026-04-19T13:39:38.826432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.004517ms","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-04-19T13:39:38.826498Z","caller":"traceutil/trace.go:171","msg":"trace[958548147] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:5285; }","duration":"306.081017ms","start":"2026-04-19T13:39:38.52038Z","end":"2026-04-19T13:39:38.826461Z","steps":["trace[958548147] 'agreement among raft nodes before linearized reading' (duration: 305.834642ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:39:38.826494Z","caller":"traceutil/trace.go:171","msg":"trace[14908903] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5285; }","duration":"305.092998ms","start":"2026-04-19T13:39:38.521384Z","end":"2026-04-19T13:39:38.826477Z","steps":["trace[14908903] 'agreement among raft nodes before linearized reading' (duration: 304.856064ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:39:38.826542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:39:38.520362Z","time spent":"306.170468ms","remote":"127.0.0.1:46436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":1309,"request content":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" "} {"level":"warn","ts":"2026-04-19T13:39:38.826561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:39:38.521378Z","time spent":"305.16917ms","remote":"127.0.0.1:46432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-19T13:39:38.826559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.163907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-04-19T13:39:38.826699Z","caller":"traceutil/trace.go:171","msg":"trace[410648248] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5285; }","duration":"279.371942ms","start":"2026-04-19T13:39:38.547297Z","end":"2026-04-19T13:39:38.826669Z","steps":["trace[410648248] 'agreement among raft nodes before linearized reading' (duration: 278.972544ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:41:12.034055Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2990} {"level":"info","ts":"2026-04-19T13:41:12.10416Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2990,"took":"68.879662ms","hash":952503946,"current-db-size-bytes":58806272,"current-db-size":"59 MB","current-db-size-in-use-bytes":34185216,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-19T13:41:12.104223Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":952503946,"revision":2990,"compact-revision":-1} {"level":"info","ts":"2026-04-19T13:45:35.829251Z","caller":"traceutil/trace.go:171","msg":"trace[1887045634] linearizableReadLoop","detail":"{readStateIndex:8364; appliedIndex:8363; }","duration":"113.370011ms","start":"2026-04-19T13:45:35.715858Z","end":"2026-04-19T13:45:35.829228Z","steps":["trace[1887045634] 'read index received' (duration: 113.194607ms)","trace[1887045634] 'applied index is now lower than readState.Index' (duration: 174.774µs)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:45:35.829562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.689636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:45:35.829619Z","caller":"traceutil/trace.go:171","msg":"trace[906807161] transaction","detail":"{read_only:false; response_revision:8081; number_of_response:1; }","duration":"206.521618ms","start":"2026-04-19T13:45:35.623073Z","end":"2026-04-19T13:45:35.829595Z","steps":["trace[906807161] 'process raft request' (duration: 206.033939ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:45:35.829654Z","caller":"traceutil/trace.go:171","msg":"trace[1304100968] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8081; }","duration":"113.822299ms","start":"2026-04-19T13:45:35.715817Z","end":"2026-04-19T13:45:35.829639Z","steps":["trace[1304100968] 'agreement among raft nodes before linearized reading' (duration: 113.667346ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:45:35.829683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.325197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-19T13:45:35.829773Z","caller":"traceutil/trace.go:171","msg":"trace[1849394730] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:8081; }","duration":"106.47924ms","start":"2026-04-19T13:45:35.723275Z","end":"2026-04-19T13:45:35.829754Z","steps":["trace[1849394730] 'agreement among raft nodes before linearized reading' (duration: 106.268466ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:45:35.993621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.294636ms","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-04-19T13:45:35.993721Z","caller":"traceutil/trace.go:171","msg":"trace[260222393] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8081; }","duration":"116.460499ms","start":"2026-04-19T13:45:35.877239Z","end":"2026-04-19T13:45:35.9937Z","steps":["trace[260222393] 'range keys from in-memory index tree' (duration: 116.100782ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:45:47.49324Z","caller":"traceutil/trace.go:171","msg":"trace[869568372] transaction","detail":"{read_only:false; response_revision:8142; number_of_response:1; }","duration":"125.720893ms","start":"2026-04-19T13:45:47.367495Z","end":"2026-04-19T13:45:47.493216Z","steps":["trace[869568372] 'process raft request' (duration: 125.578931ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:45:47.637418Z","caller":"traceutil/trace.go:171","msg":"trace[120863276] linearizableReadLoop","detail":"{readStateIndex:8429; appliedIndex:8427; }","duration":"242.859024ms","start":"2026-04-19T13:45:47.394531Z","end":"2026-04-19T13:45:47.63739Z","steps":["trace[120863276] 'read index received' (duration: 98.5258ms)","trace[120863276] 'applied index is now lower than readState.Index' (duration: 144.331954ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:45:47.637629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.088239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-9ng4g\" ","response":"range_response_count:1 size:6527"} {"level":"warn","ts":"2026-04-19T13:45:47.637706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.982206ms","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-04-19T13:45:47.637724Z","caller":"traceutil/trace.go:171","msg":"trace[914856170] range","detail":"{range_begin:/registry/pods/openstack/keepalived-9ng4g; range_end:; response_count:1; response_revision:8143; }","duration":"243.222321ms","start":"2026-04-19T13:45:47.394479Z","end":"2026-04-19T13:45:47.637701Z","steps":["trace[914856170] 'agreement among raft nodes before linearized reading' (duration: 242.996897ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:45:47.637763Z","caller":"traceutil/trace.go:171","msg":"trace[53454640] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8143; }","duration":"172.084418ms","start":"2026-04-19T13:45:47.465664Z","end":"2026-04-19T13:45:47.637748Z","steps":["trace[53454640] 'agreement among raft nodes before linearized reading' (duration: 171.890424ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:45:47.637471Z","caller":"traceutil/trace.go:171","msg":"trace[517988747] transaction","detail":"{read_only:false; response_revision:8143; number_of_response:1; }","duration":"269.436756ms","start":"2026-04-19T13:45:47.368008Z","end":"2026-04-19T13:45:47.637444Z","steps":["trace[517988747] 'process raft request' (duration: 264.083185ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:45:48.594358Z","caller":"traceutil/trace.go:171","msg":"trace[145138667] transaction","detail":"{read_only:false; response_revision:8148; number_of_response:1; }","duration":"193.581064ms","start":"2026-04-19T13:45:48.400743Z","end":"2026-04-19T13:45:48.594324Z","steps":["trace[145138667] 'process raft request' (duration: 193.408831ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:45:48.669955Z","caller":"traceutil/trace.go:171","msg":"trace[1711005431] transaction","detail":"{read_only:false; response_revision:8149; number_of_response:1; }","duration":"264.917901ms","start":"2026-04-19T13:45:48.405013Z","end":"2026-04-19T13:45:48.669931Z","steps":["trace[1711005431] 'process raft request' (duration: 264.752898ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:45:49.843792Z","caller":"traceutil/trace.go:171","msg":"trace[533642391] linearizableReadLoop","detail":"{readStateIndex:8439; appliedIndex:8438; }","duration":"145.996135ms","start":"2026-04-19T13:45:49.697764Z","end":"2026-04-19T13:45:49.84376Z","steps":["trace[533642391] 'read index received' (duration: 145.320652ms)","trace[533642391] 'applied index is now lower than readState.Index' (duration: 674.353µs)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:45:49.843941Z","caller":"traceutil/trace.go:171","msg":"trace[2097185156] transaction","detail":"{read_only:false; response_revision:8153; number_of_response:1; }","duration":"146.444085ms","start":"2026-04-19T13:45:49.697458Z","end":"2026-04-19T13:45:49.843902Z","steps":["trace[2097185156] 'process raft request' (duration: 145.623549ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:45:49.844221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.196273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T13:45:49.844277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.285761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-9ng4g\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-04-19T13:45:49.84436Z","caller":"traceutil/trace.go:171","msg":"trace[875687677] range","detail":"{range_begin:/registry/pods/openstack/keepalived-9ng4g; range_end:; response_count:1; response_revision:8153; }","duration":"146.604657ms","start":"2026-04-19T13:45:49.697742Z","end":"2026-04-19T13:45:49.844346Z","steps":["trace[875687677] 'agreement among raft nodes before linearized reading' (duration: 146.162999ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:45:49.844379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.905041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-19T13:45:49.844483Z","caller":"traceutil/trace.go:171","msg":"trace[987935320] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:8153; }","duration":"114.021783ms","start":"2026-04-19T13:45:49.730413Z","end":"2026-04-19T13:45:49.844435Z","steps":["trace[987935320] 'agreement among raft nodes before linearized reading' (duration: 113.817059ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:45:49.844302Z","caller":"traceutil/trace.go:171","msg":"trace[1568391543] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8153; }","duration":"125.302046ms","start":"2026-04-19T13:45:49.718979Z","end":"2026-04-19T13:45:49.844281Z","steps":["trace[1568391543] 'agreement among raft nodes before linearized reading' (duration: 125.181274ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:46:12.040314Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6110} {"level":"info","ts":"2026-04-19T13:46:12.129398Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6110,"took":"86.821608ms","hash":1157497224,"current-db-size-bytes":58806272,"current-db-size":"59 MB","current-db-size-in-use-bytes":22900736,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-19T13:46:12.129464Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1157497224,"revision":6110,"compact-revision":2990} {"level":"warn","ts":"2026-04-19T13:46:16.244878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.695369ms","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-04-19T13:46:16.244943Z","caller":"traceutil/trace.go:171","msg":"trace[1749570195] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8346; }","duration":"280.80722ms","start":"2026-04-19T13:46:15.964122Z","end":"2026-04-19T13:46:16.24493Z","steps":["trace[1749570195] 'range keys from in-memory index tree' (duration: 280.532935ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:46:16.245133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.154875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-19T13:46:16.245209Z","caller":"traceutil/trace.go:171","msg":"trace[1387069939] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8346; }","duration":"469.274288ms","start":"2026-04-19T13:46:15.775916Z","end":"2026-04-19T13:46:16.24519Z","steps":["trace[1387069939] 'range keys from in-memory index tree' (duration: 468.982342ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:46:16.245255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:46:15.775895Z","time spent":"469.351619ms","remote":"127.0.0.1:46500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-19T13:46:16.245286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.662443ms","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-04-19T13:46:16.245319Z","caller":"traceutil/trace.go:171","msg":"trace[1433069964] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8346; }","duration":"213.733844ms","start":"2026-04-19T13:46:16.031575Z","end":"2026-04-19T13:46:16.245309Z","steps":["trace[1433069964] 'range keys from in-memory index tree' (duration: 213.553601ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:46:16.24544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.601605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-7467d8d764-bg2s9.18a7c60a7783494f\" ","response":"range_response_count:1 size:1134"} {"level":"info","ts":"2026-04-19T13:46:16.245477Z","caller":"traceutil/trace.go:171","msg":"trace[191954401] range","detail":"{range_begin:/registry/events/openstack/barbican-api-7467d8d764-bg2s9.18a7c60a7783494f; range_end:; response_count:1; response_revision:8346; }","duration":"140.633355ms","start":"2026-04-19T13:46:16.10483Z","end":"2026-04-19T13:46:16.245463Z","steps":["trace[191954401] 'range keys from in-memory index tree' (duration: 140.498802ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:46:16.245214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.664463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-9ng4g\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-04-19T13:46:16.245868Z","caller":"traceutil/trace.go:171","msg":"trace[1271246463] range","detail":"{range_begin:/registry/pods/openstack/keepalived-9ng4g; range_end:; response_count:1; response_revision:8346; }","duration":"241.357386ms","start":"2026-04-19T13:46:16.004496Z","end":"2026-04-19T13:46:16.245853Z","steps":["trace[1271246463] 'range keys from in-memory index tree' (duration: 240.560501ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:46:28.716972Z","caller":"traceutil/trace.go:171","msg":"trace[923563776] transaction","detail":"{read_only:false; response_revision:8460; number_of_response:1; }","duration":"175.678306ms","start":"2026-04-19T13:46:28.541261Z","end":"2026-04-19T13:46:28.716939Z","steps":["trace[923563776] 'process raft request' (duration: 175.514693ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:46:28.873708Z","caller":"traceutil/trace.go:171","msg":"trace[265642327] transaction","detail":"{read_only:false; response_revision:8461; number_of_response:1; }","duration":"326.192037ms","start":"2026-04-19T13:46:28.547483Z","end":"2026-04-19T13:46:28.873675Z","steps":["trace[265642327] 'process raft request' (duration: 326.017364ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:46:28.873875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:46:28.547474Z","time spent":"326.315229ms","remote":"127.0.0.1:46432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4634,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T13:46:28.874007Z","caller":"traceutil/trace.go:171","msg":"trace[1664457920] linearizableReadLoop","detail":"{readStateIndex:8761; appliedIndex:8761; }","duration":"152.458037ms","start":"2026-04-19T13:46:28.721519Z","end":"2026-04-19T13:46:28.873977Z","steps":["trace[1664457920] 'read index received' (duration: 152.436807ms)","trace[1664457920] 'applied index is now lower than readState.Index' (duration: 19.19µs)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:46:28.874188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.652991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:46:28.874251Z","caller":"traceutil/trace.go:171","msg":"trace[1291151891] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8461; }","duration":"152.755593ms","start":"2026-04-19T13:46:28.72147Z","end":"2026-04-19T13:46:28.874226Z","steps":["trace[1291151891] 'agreement among raft nodes before linearized reading' (duration: 152.61438ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:46:28.890083Z","caller":"traceutil/trace.go:171","msg":"trace[1398072401] transaction","detail":"{read_only:false; response_revision:8462; number_of_response:1; }","duration":"152.202573ms","start":"2026-04-19T13:46:28.737861Z","end":"2026-04-19T13:46:28.890063Z","steps":["trace[1398072401] 'process raft request' (duration: 152.03384ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:47:19.022003Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002437.wal"} {"level":"info","ts":"2026-04-19T13:48:50.927262Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d0ba3c4de8c6ef7a","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-19T13:48:50.932227Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-19T13:48:50.932363Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-19T13:51:12.045924Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8284} {"level":"info","ts":"2026-04-19T13:51:12.12567Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8284,"took":"77.907712ms","hash":1569192268,"current-db-size-bytes":58806272,"current-db-size":"59 MB","current-db-size-in-use-bytes":24784896,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-19T13:51:12.125748Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1569192268,"revision":8284,"compact-revision":6110} {"level":"info","ts":"2026-04-19T13:56:12.053377Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10673} {"level":"info","ts":"2026-04-19T13:56:12.131582Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10673,"took":"76.533957ms","hash":3868546111,"current-db-size-bytes":58806272,"current-db-size":"59 MB","current-db-size-in-use-bytes":20201472,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-19T13:56:12.131641Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3868546111,"revision":10673,"compact-revision":8284}