{"level":"warn","ts":"2026-03-13T23:06:20.12242Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-13T23:06:20.122509Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.205: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.205:2380","--initial-cluster=instance=https://199.204.45.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.205: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-03-13T23:06:20.122582Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-13T23:06:20.122591Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-03-13T23:06:20.122607Z","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-03-13T23:06:20.123233Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"]} {"level":"info","ts":"2026-03-13T23:06:20.123305Z","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.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.205: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-03-13T23:06:20.127369Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.801167ms"} {"level":"info","ts":"2026-03-13T23:06:20.139128Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"71d28e9ac1bc4e5d","cluster-id":"4a4ae660c7a9a6a7"} {"level":"info","ts":"2026-03-13T23:06:20.139258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=()"} {"level":"info","ts":"2026-03-13T23:06:20.139294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 0"} {"level":"info","ts":"2026-03-13T23:06:20.139307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 71d28e9ac1bc4e5d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-13T23:06:20.139322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 1"} {"level":"info","ts":"2026-03-13T23:06:20.139377Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"warn","ts":"2026-03-13T23:06:20.149508Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-13T23:06:20.152009Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-13T23:06:20.154812Z","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-03-13T23:06:20.157267Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"71d28e9ac1bc4e5d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-13T23:06:20.157463Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"71d28e9ac1bc4e5d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-13T23:06:20.157519Z","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-03-13T23:06:20.157682Z","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-03-13T23:06:20.157731Z","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-03-13T23:06:20.16007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"info","ts":"2026-03-13T23:06:20.160691Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","added-peer-id":"71d28e9ac1bc4e5d","added-peer-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-03-13T23:06:20.161841Z","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-03-13T23:06:20.161925Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-03-13T23:06:20.161956Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-03-13T23:06:20.162152Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"71d28e9ac1bc4e5d","initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-13T23:06:20.162242Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-13T23:06:20.740656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d is starting a new election at term 1"} {"level":"info","ts":"2026-03-13T23:06:20.740733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became pre-candidate at term 1"} {"level":"info","ts":"2026-03-13T23:06:20.740769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgPreVoteResp from 71d28e9ac1bc4e5d at term 1"} {"level":"info","ts":"2026-03-13T23:06:20.740788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became candidate at term 2"} {"level":"info","ts":"2026-03-13T23:06:20.7408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgVoteResp from 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-03-13T23:06:20.740815Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became leader at term 2"} {"level":"info","ts":"2026-03-13T23:06:20.740835Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 71d28e9ac1bc4e5d elected leader 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-03-13T23:06:20.741941Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-13T23:06:20.741945Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"71d28e9ac1bc4e5d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.205:2379]}","request-path":"/0/members/71d28e9ac1bc4e5d/attributes","cluster-id":"4a4ae660c7a9a6a7","publish-timeout":"7s"} {"level":"info","ts":"2026-03-13T23:06:20.741964Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-13T23:06:20.742153Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-13T23:06:20.742306Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-13T23:06:20.742362Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-13T23:06:20.742977Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","cluster-version":"3.5"} {"level":"info","ts":"2026-03-13T23:06:20.743229Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-13T23:06:20.743287Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-13T23:06:20.744487Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.205:2379"} {"level":"info","ts":"2026-03-13T23:06:20.745272Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-03-13T23:06:48.267909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.882413ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-13T23:06:48.268217Z","caller":"traceutil/trace.go:171","msg":"trace[880738189] linearizableReadLoop","detail":"{readStateIndex:450; appliedIndex:448; }","duration":"274.432412ms","start":"2026-03-13T23:06:47.993739Z","end":"2026-03-13T23:06:48.268171Z","steps":["trace[880738189] 'read index received' (duration: 23.022773ms)","trace[880738189] 'applied index is now lower than readState.Index' (duration: 251.408399ms)"],"step_count":2} {"level":"info","ts":"2026-03-13T23:06:48.26821Z","caller":"traceutil/trace.go:171","msg":"trace[737744679] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"280.871219ms","start":"2026-03-13T23:06:47.987289Z","end":"2026-03-13T23:06:48.26816Z","steps":["trace[737744679] 'marshal mvccpb.KeyValue' {req_type:put; key:/registry/clusterroles/cilium-operator; req_size:2361; } (duration: 270.150162ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:06:48.268418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.670528ms","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-03-13T23:06:48.268521Z","caller":"traceutil/trace.go:171","msg":"trace[652090607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:431; }","duration":"274.803202ms","start":"2026-03-13T23:06:47.993694Z","end":"2026-03-13T23:06:48.268498Z","steps":["trace[652090607] 'agreement among raft nodes before linearized reading' (duration: 274.614357ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:06:48.26847Z","caller":"traceutil/trace.go:171","msg":"trace[1383565587] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"280.356715ms","start":"2026-03-13T23:06:47.988067Z","end":"2026-03-13T23:06:48.268424Z","steps":["trace[1383565587] 'process raft request' (duration: 279.992675ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:06:55.963014Z","caller":"traceutil/trace.go:171","msg":"trace[944463519] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"209.454077ms","start":"2026-03-13T23:06:55.753539Z","end":"2026-03-13T23:06:55.962993Z","steps":["trace[944463519] 'process raft request' (duration: 209.320713ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:06:56.41792Z","caller":"traceutil/trace.go:171","msg":"trace[1514727856] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"109.02186ms","start":"2026-03-13T23:06:56.308872Z","end":"2026-03-13T23:06:56.417894Z","steps":["trace[1514727856] 'process raft request' (duration: 108.872976ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:06:56.436459Z","caller":"traceutil/trace.go:171","msg":"trace[893628500] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"127.491087ms","start":"2026-03-13T23:06:56.308951Z","end":"2026-03-13T23:06:56.436442Z","steps":["trace[893628500] 'process raft request' (duration: 127.389034ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:06:56.584859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.487496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-03-13T23:06:56.585356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.873548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-qxsww\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-03-13T23:06:56.585463Z","caller":"traceutil/trace.go:171","msg":"trace[2044120683] range","detail":"{range_begin:/registry/pods/kube-system/cilium-qxsww; range_end:; response_count:1; response_revision:505; }","duration":"126.97952ms","start":"2026-03-13T23:06:56.458446Z","end":"2026-03-13T23:06:56.585426Z","steps":["trace[2044120683] 'range keys from in-memory index tree' (duration: 126.357355ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:06:56.58551Z","caller":"traceutil/trace.go:171","msg":"trace[1789982953] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:505; }","duration":"139.63979ms","start":"2026-03-13T23:06:56.445296Z","end":"2026-03-13T23:06:56.584936Z","steps":["trace[1789982953] 'range keys from in-memory index tree' (duration: 139.270311ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:06:57.703019Z","caller":"traceutil/trace.go:171","msg":"trace[1697571407] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"119.153844ms","start":"2026-03-13T23:06:57.583819Z","end":"2026-03-13T23:06:57.702973Z","steps":["trace[1697571407] 'process raft request' (duration: 118.916639ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:06:57.703084Z","caller":"traceutil/trace.go:171","msg":"trace[356725195] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"113.999351ms","start":"2026-03-13T23:06:57.589057Z","end":"2026-03-13T23:06:57.703056Z","steps":["trace[356725195] 'process raft request' (duration: 113.830287ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:06:57.703197Z","caller":"traceutil/trace.go:171","msg":"trace[135140028] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"113.52753ms","start":"2026-03-13T23:06:57.589647Z","end":"2026-03-13T23:06:57.703174Z","steps":["trace[135140028] 'process raft request' (duration: 113.299415ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:07:24.963306Z","caller":"traceutil/trace.go:171","msg":"trace[44453358] linearizableReadLoop","detail":"{readStateIndex:928; appliedIndex:927; }","duration":"165.939616ms","start":"2026-03-13T23:07:24.797319Z","end":"2026-03-13T23:07:24.963258Z","steps":["trace[44453358] 'read index received' (duration: 114.152544ms)","trace[44453358] 'applied index is now lower than readState.Index' (duration: 51.784982ms)"],"step_count":2} {"level":"info","ts":"2026-03-13T23:07:24.963386Z","caller":"traceutil/trace.go:171","msg":"trace[1346375811] transaction","detail":"{read_only:false; response_revision:900; number_of_response:1; }","duration":"196.671147ms","start":"2026-03-13T23:07:24.76667Z","end":"2026-03-13T23:07:24.963341Z","steps":["trace[1346375811] 'process raft request' (duration: 144.737512ms)","trace[1346375811] 'compare' (duration: 51.669289ms)"],"step_count":2} {"level":"warn","ts":"2026-03-13T23:07:24.963596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.258604ms","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-03-13T23:07:24.963701Z","caller":"traceutil/trace.go:171","msg":"trace[702036455] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:900; }","duration":"166.377767ms","start":"2026-03-13T23:07:24.797299Z","end":"2026-03-13T23:07:24.963677Z","steps":["trace[702036455] 'agreement among raft nodes before linearized reading' (duration: 166.107901ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:08:18.144263Z","caller":"traceutil/trace.go:171","msg":"trace[1455901917] linearizableReadLoop","detail":"{readStateIndex:1628; appliedIndex:1627; }","duration":"257.960464ms","start":"2026-03-13T23:08:17.886267Z","end":"2026-03-13T23:08:18.144227Z","steps":["trace[1455901917] 'read index received' (duration: 194.327451ms)","trace[1455901917] 'applied index is now lower than readState.Index' (duration: 63.631233ms)"],"step_count":2} {"level":"info","ts":"2026-03-13T23:08:18.144399Z","caller":"traceutil/trace.go:171","msg":"trace[734973042] transaction","detail":"{read_only:false; response_revision:1564; number_of_response:1; }","duration":"267.817152ms","start":"2026-03-13T23:08:17.876557Z","end":"2026-03-13T23:08:18.144374Z","steps":["trace[734973042] 'process raft request' (duration: 204.086996ms)","trace[734973042] 'compare' (duration: 63.287435ms)"],"step_count":2} {"level":"warn","ts":"2026-03-13T23:08:18.144568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.277091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-03-13T23:08:18.144714Z","caller":"traceutil/trace.go:171","msg":"trace[1211125475] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1564; }","duration":"258.413195ms","start":"2026-03-13T23:08:17.886241Z","end":"2026-03-13T23:08:18.144654Z","steps":["trace[1211125475] 'agreement among raft nodes before linearized reading' (duration: 258.138769ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:08:18.199549Z","caller":"traceutil/trace.go:171","msg":"trace[862569450] transaction","detail":"{read_only:false; response_revision:1565; number_of_response:1; }","duration":"292.216566ms","start":"2026-03-13T23:08:17.907288Z","end":"2026-03-13T23:08:18.199504Z","steps":["trace[862569450] 'process raft request' (duration: 292.042712ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:08:18.199657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.251633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4c572ce4-031d-4c5f-8e8f-e3159785b02d\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-03-13T23:08:18.199728Z","caller":"traceutil/trace.go:171","msg":"trace[1648326382] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4c572ce4-031d-4c5f-8e8f-e3159785b02d; range_end:; response_count:1; response_revision:1565; }","duration":"107.335465ms","start":"2026-03-13T23:08:18.092373Z","end":"2026-03-13T23:08:18.199708Z","steps":["trace[1648326382] 'agreement among raft nodes before linearized reading' (duration: 107.11354ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:08:18.310029Z","caller":"traceutil/trace.go:171","msg":"trace[668634193] transaction","detail":"{read_only:false; response_revision:1569; number_of_response:1; }","duration":"160.104587ms","start":"2026-03-13T23:08:18.149887Z","end":"2026-03-13T23:08:18.309992Z","steps":["trace[668634193] 'process raft request' (duration: 94.299143ms)","trace[668634193] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/services/endpoints/openstack/percona-xtradb-haproxy; req_size:975; } (duration: 65.514647ms)"],"step_count":2} {"level":"info","ts":"2026-03-13T23:08:18.310263Z","caller":"traceutil/trace.go:171","msg":"trace[1511779954] linearizableReadLoop","detail":"{readStateIndex:1634; appliedIndex:1629; }","duration":"110.779236ms","start":"2026-03-13T23:08:18.199462Z","end":"2026-03-13T23:08:18.310241Z","steps":["trace[1511779954] 'read index received' (duration: 44.152073ms)","trace[1511779954] 'applied index is now lower than readState.Index' (duration: 66.626153ms)"],"step_count":2} {"level":"info","ts":"2026-03-13T23:08:18.310381Z","caller":"traceutil/trace.go:171","msg":"trace[2001492269] transaction","detail":"{read_only:false; response_revision:1570; number_of_response:1; }","duration":"160.177709ms","start":"2026-03-13T23:08:18.150192Z","end":"2026-03-13T23:08:18.31037Z","steps":["trace[2001492269] 'process raft request' (duration: 159.725279ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:08:18.310562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.879391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4c572ce4-031d-4c5f-8e8f-e3159785b02d\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-03-13T23:08:18.310632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.820108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-13T23:08:18.310665Z","caller":"traceutil/trace.go:171","msg":"trace[1183347024] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4c572ce4-031d-4c5f-8e8f-e3159785b02d; range_end:; response_count:1; response_revision:1570; }","duration":"163.047535ms","start":"2026-03-13T23:08:18.147601Z","end":"2026-03-13T23:08:18.310648Z","steps":["trace[1183347024] 'agreement among raft nodes before linearized reading' (duration: 162.782259ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:08:18.310683Z","caller":"traceutil/trace.go:171","msg":"trace[1490771942] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1570; }","duration":"136.921861ms","start":"2026-03-13T23:08:18.173751Z","end":"2026-03-13T23:08:18.310673Z","steps":["trace[1490771942] 'agreement among raft nodes before linearized reading' (duration: 136.787938ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:08:18.626552Z","caller":"traceutil/trace.go:171","msg":"trace[1041231948] linearizableReadLoop","detail":"{readStateIndex:1635; appliedIndex:1634; }","duration":"193.663474ms","start":"2026-03-13T23:08:18.432865Z","end":"2026-03-13T23:08:18.626529Z","steps":["trace[1041231948] 'read index received' (duration: 189.139799ms)","trace[1041231948] 'applied index is now lower than readState.Index' (duration: 4.522365ms)"],"step_count":2} {"level":"info","ts":"2026-03-13T23:08:18.626565Z","caller":"traceutil/trace.go:171","msg":"trace[1356483777] transaction","detail":"{read_only:false; response_revision:1571; number_of_response:1; }","duration":"309.059307ms","start":"2026-03-13T23:08:18.317477Z","end":"2026-03-13T23:08:18.626536Z","steps":["trace[1356483777] 'process raft request' (duration: 304.488751ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:08:18.626943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.053883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-03-13T23:08:18.627046Z","caller":"traceutil/trace.go:171","msg":"trace[159506770] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1571; }","duration":"194.203536ms","start":"2026-03-13T23:08:18.43282Z","end":"2026-03-13T23:08:18.627023Z","steps":["trace[159506770] 'agreement among raft nodes before linearized reading' (duration: 193.837448ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:08:18.627331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T23:08:18.317458Z","time spent":"309.240352ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-13T23:08:57.172816Z","caller":"traceutil/trace.go:171","msg":"trace[990345082] transaction","detail":"{read_only:false; response_revision:1811; number_of_response:1; }","duration":"141.446065ms","start":"2026-03-13T23:08:57.031339Z","end":"2026-03-13T23:08:57.172785Z","steps":["trace[990345082] 'process raft request' (duration: 120.94474ms)","trace[990345082] 'compare' (duration: 20.400802ms)"],"step_count":2} {"level":"warn","ts":"2026-03-13T23:09:09.134327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.612359ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-03-13T23:09:09.134444Z","caller":"traceutil/trace.go:171","msg":"trace[1156457848] linearizableReadLoop","detail":"{readStateIndex:1943; appliedIndex:1942; }","duration":"187.540285ms","start":"2026-03-13T23:09:08.946886Z","end":"2026-03-13T23:09:09.134426Z","steps":["trace[1156457848] 'read index received' (duration: 38.728351ms)","trace[1156457848] 'applied index is now lower than readState.Index' (duration: 148.810324ms)"],"step_count":2} {"level":"warn","ts":"2026-03-13T23:09:09.134662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.76482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-03-13T23:09:09.134698Z","caller":"traceutil/trace.go:171","msg":"trace[1590915613] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1866; }","duration":"187.847162ms","start":"2026-03-13T23:09:08.94684Z","end":"2026-03-13T23:09:09.134687Z","steps":["trace[1590915613] 'agreement among raft nodes before linearized reading' (duration: 187.701659ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:09:09.267341Z","caller":"traceutil/trace.go:171","msg":"trace[1542911439] linearizableReadLoop","detail":"{readStateIndex:1944; appliedIndex:1943; }","duration":"122.033872ms","start":"2026-03-13T23:09:09.145278Z","end":"2026-03-13T23:09:09.267312Z","steps":["trace[1542911439] 'read index received' (duration: 121.738925ms)","trace[1542911439] 'applied index is now lower than readState.Index' (duration: 293.697µs)"],"step_count":2} {"level":"info","ts":"2026-03-13T23:09:09.267444Z","caller":"traceutil/trace.go:171","msg":"trace[477590602] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"125.388001ms","start":"2026-03-13T23:09:09.142027Z","end":"2026-03-13T23:09:09.267415Z","steps":["trace[477590602] 'process raft request' (duration: 125.072894ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:09:09.267625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.318909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-03-13T23:09:09.268023Z","caller":"traceutil/trace.go:171","msg":"trace[2016465354] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1867; }","duration":"122.609015ms","start":"2026-03-13T23:09:09.145273Z","end":"2026-03-13T23:09:09.267882Z","steps":["trace[2016465354] 'agreement among raft nodes before linearized reading' (duration: 122.174665ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:10:30.048504Z","caller":"traceutil/trace.go:171","msg":"trace[917377076] transaction","detail":"{read_only:false; response_revision:2460; number_of_response:1; }","duration":"114.237311ms","start":"2026-03-13T23:10:29.934244Z","end":"2026-03-13T23:10:30.048481Z","steps":["trace[917377076] 'process raft request' (duration: 114.104957ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:10:30.087886Z","caller":"traceutil/trace.go:171","msg":"trace[701732151] transaction","detail":"{read_only:false; response_revision:2461; number_of_response:1; }","duration":"152.830524ms","start":"2026-03-13T23:10:29.935009Z","end":"2026-03-13T23:10:30.087839Z","steps":["trace[701732151] 'process raft request' (duration: 152.722311ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:10:30.474806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.195932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-13T23:10:30.47489Z","caller":"traceutil/trace.go:171","msg":"trace[284737838] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:2462; }","duration":"139.332737ms","start":"2026-03-13T23:10:30.335539Z","end":"2026-03-13T23:10:30.474872Z","steps":["trace[284737838] 'count revisions from in-memory index tree' (duration: 139.09365ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:14:20.997579Z","caller":"traceutil/trace.go:171","msg":"trace[1976676071] transaction","detail":"{read_only:false; response_revision:4304; number_of_response:1; }","duration":"126.171482ms","start":"2026-03-13T23:14:20.871381Z","end":"2026-03-13T23:14:20.997553Z","steps":["trace[1976676071] 'process raft request' (duration: 117.61915ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:14:21.00084Z","caller":"traceutil/trace.go:171","msg":"trace[925027130] linearizableReadLoop","detail":"{readStateIndex:4483; appliedIndex:4481; }","duration":"123.206412ms","start":"2026-03-13T23:14:20.877607Z","end":"2026-03-13T23:14:21.000813Z","steps":["trace[925027130] 'read index received' (duration: 111.378361ms)","trace[925027130] 'applied index is now lower than readState.Index' (duration: 11.826881ms)"],"step_count":2} {"level":"info","ts":"2026-03-13T23:14:21.000947Z","caller":"traceutil/trace.go:171","msg":"trace[756968482] transaction","detail":"{read_only:false; response_revision:4305; number_of_response:1; }","duration":"129.102092ms","start":"2026-03-13T23:14:20.871807Z","end":"2026-03-13T23:14:21.000909Z","steps":["trace[756968482] 'process raft request' (duration: 128.847566ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:14:21.001055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.437868ms","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-03-13T23:14:21.001138Z","caller":"traceutil/trace.go:171","msg":"trace[1957259603] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4305; }","duration":"123.575582ms","start":"2026-03-13T23:14:20.877541Z","end":"2026-03-13T23:14:21.001117Z","steps":["trace[1957259603] 'agreement among raft nodes before linearized reading' (duration: 123.365426ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:14:23.460663Z","caller":"traceutil/trace.go:171","msg":"trace[1412424344] transaction","detail":"{read_only:false; response_revision:4360; number_of_response:1; }","duration":"101.512928ms","start":"2026-03-13T23:14:23.359119Z","end":"2026-03-13T23:14:23.460632Z","steps":["trace[1412424344] 'process raft request' (duration: 101.288391ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:14:25.85113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.390299ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-13T23:14:25.851305Z","caller":"traceutil/trace.go:171","msg":"trace[1643451802] transaction","detail":"{read_only:false; response_revision:4501; number_of_response:1; }","duration":"159.145634ms","start":"2026-03-13T23:14:25.692133Z","end":"2026-03-13T23:14:25.851279Z","steps":["trace[1643451802] 'process raft request' (duration: 56.451729ms)","trace[1643451802] 'compare' (duration: 102.130002ms)"],"step_count":2} {"level":"info","ts":"2026-03-13T23:14:25.877057Z","caller":"traceutil/trace.go:171","msg":"trace[1832444502] transaction","detail":"{read_only:false; response_revision:4502; number_of_response:1; }","duration":"182.725852ms","start":"2026-03-13T23:14:25.694275Z","end":"2026-03-13T23:14:25.877001Z","steps":["trace[1832444502] 'process raft request' (duration: 182.450446ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:14:25.877097Z","caller":"traceutil/trace.go:171","msg":"trace[131624077] linearizableReadLoop","detail":"{readStateIndex:4689; appliedIndex:4686; }","duration":"174.567119ms","start":"2026-03-13T23:14:25.702511Z","end":"2026-03-13T23:14:25.877078Z","steps":["trace[131624077] 'read index received' (duration: 46.052052ms)","trace[131624077] 'applied index is now lower than readState.Index' (duration: 128.513527ms)"],"step_count":2} {"level":"warn","ts":"2026-03-13T23:14:25.877309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.791344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-rxd2c\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-03-13T23:14:25.877347Z","caller":"traceutil/trace.go:171","msg":"trace[672329765] range","detail":"{range_begin:/registry/pods/openstack/keepalived-rxd2c; range_end:; response_count:1; response_revision:4503; }","duration":"174.847285ms","start":"2026-03-13T23:14:25.702489Z","end":"2026-03-13T23:14:25.877337Z","steps":["trace[672329765] 'agreement among raft nodes before linearized reading' (duration: 174.645411ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:14:25.877371Z","caller":"traceutil/trace.go:171","msg":"trace[1432807281] transaction","detail":"{read_only:false; response_revision:4503; number_of_response:1; }","duration":"179.894765ms","start":"2026-03-13T23:14:25.697445Z","end":"2026-03-13T23:14:25.87734Z","steps":["trace[1432807281] 'process raft request' (duration: 179.419964ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:14:37.976707Z","caller":"traceutil/trace.go:171","msg":"trace[1260103549] transaction","detail":"{read_only:false; response_revision:4726; number_of_response:1; }","duration":"132.31857ms","start":"2026-03-13T23:14:37.844371Z","end":"2026-03-13T23:14:37.97669Z","steps":["trace[1260103549] 'process raft request' (duration: 131.909731ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:14:47.084632Z","caller":"traceutil/trace.go:171","msg":"trace[416776840] transaction","detail":"{read_only:false; response_revision:4896; number_of_response:1; }","duration":"148.244797ms","start":"2026-03-13T23:14:46.936345Z","end":"2026-03-13T23:14:47.08459Z","steps":["trace[416776840] 'process raft request' (duration: 148.017761ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:14:49.235721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.801919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3565"} {"level":"info","ts":"2026-03-13T23:14:49.23584Z","caller":"traceutil/trace.go:171","msg":"trace[782527084] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4942; }","duration":"185.538456ms","start":"2026-03-13T23:14:49.050262Z","end":"2026-03-13T23:14:49.2358Z","steps":["trace[782527084] 'range keys from in-memory index tree' (duration: 184.620045ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:16:20.769451Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2712} {"level":"info","ts":"2026-03-13T23:16:20.823162Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2712,"took":"52.371619ms","hash":3467504226,"current-db-size-bytes":41275392,"current-db-size":"41 MB","current-db-size-in-use-bytes":31203328,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-03-13T23:16:20.823266Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3467504226,"revision":2712,"compact-revision":-1} {"level":"warn","ts":"2026-03-13T23:20:57.368185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.548926ms","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-03-13T23:20:57.368247Z","caller":"traceutil/trace.go:171","msg":"trace[2035162922] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7576; }","duration":"195.664199ms","start":"2026-03-13T23:20:57.172569Z","end":"2026-03-13T23:20:57.368233Z","steps":["trace[2035162922] 'range keys from in-memory index tree' (duration: 195.377363ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:20:57.368356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.554249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-03-13T23:20:57.368344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.816086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-03-13T23:20:57.368351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.406609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-13T23:20:57.368406Z","caller":"traceutil/trace.go:171","msg":"trace[673417583] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7576; }","duration":"199.906128ms","start":"2026-03-13T23:20:57.168484Z","end":"2026-03-13T23:20:57.36839Z","steps":["trace[673417583] 'range keys from in-memory index tree' (duration: 199.618831ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:20:57.368427Z","caller":"traceutil/trace.go:171","msg":"trace[1125275231] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7576; }","duration":"115.532742ms","start":"2026-03-13T23:20:57.252876Z","end":"2026-03-13T23:20:57.368409Z","steps":["trace[1125275231] 'range keys from in-memory index tree' (duration: 115.282045ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:20:57.368464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.874277ms","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-03-13T23:20:57.368384Z","caller":"traceutil/trace.go:171","msg":"trace[1817265700] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7576; }","duration":"211.61899ms","start":"2026-03-13T23:20:57.156759Z","end":"2026-03-13T23:20:57.368378Z","steps":["trace[1817265700] 'range keys from in-memory index tree' (duration: 211.433746ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:20:57.368543Z","caller":"traceutil/trace.go:171","msg":"trace[1181695797] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7576; }","duration":"196.973688ms","start":"2026-03-13T23:20:57.17155Z","end":"2026-03-13T23:20:57.368524Z","steps":["trace[1181695797] 'range keys from in-memory index tree' (duration: 196.701272ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:20:58.81068Z","caller":"traceutil/trace.go:171","msg":"trace[1390558349] transaction","detail":"{read_only:false; response_revision:7584; number_of_response:1; }","duration":"127.935631ms","start":"2026-03-13T23:20:58.682721Z","end":"2026-03-13T23:20:58.810657Z","steps":["trace[1390558349] 'process raft request' (duration: 127.773327ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:21:20.776813Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5680} {"level":"info","ts":"2026-03-13T23:21:20.861608Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5680,"took":"83.003204ms","hash":3406045913,"current-db-size-bytes":42561536,"current-db-size":"43 MB","current-db-size-in-use-bytes":22831104,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-03-13T23:21:20.861657Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3406045913,"revision":5680,"compact-revision":2712} {"level":"info","ts":"2026-03-13T23:21:25.704775Z","caller":"traceutil/trace.go:171","msg":"trace[276486362] linearizableReadLoop","detail":"{readStateIndex:8069; appliedIndex:8068; }","duration":"110.191057ms","start":"2026-03-13T23:21:25.594559Z","end":"2026-03-13T23:21:25.70475Z","steps":["trace[276486362] 'read index received' (duration: 109.983042ms)","trace[276486362] 'applied index is now lower than readState.Index' (duration: 206.985µs)"],"step_count":2} {"level":"info","ts":"2026-03-13T23:21:25.705063Z","caller":"traceutil/trace.go:171","msg":"trace[786270132] transaction","detail":"{read_only:false; response_revision:7771; number_of_response:1; }","duration":"151.597742ms","start":"2026-03-13T23:21:25.553448Z","end":"2026-03-13T23:21:25.705046Z","steps":["trace[786270132] 'process raft request' (duration: 151.169212ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:21:25.705365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.783701ms","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-03-13T23:21:25.705409Z","caller":"traceutil/trace.go:171","msg":"trace[781810493] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7771; }","duration":"110.855652ms","start":"2026-03-13T23:21:25.594542Z","end":"2026-03-13T23:21:25.705398Z","steps":["trace[781810493] 'agreement among raft nodes before linearized reading' (duration: 110.707518ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:21:25.705623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.977279ms","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-03-13T23:21:25.705663Z","caller":"traceutil/trace.go:171","msg":"trace[723168308] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7771; }","duration":"109.02883ms","start":"2026-03-13T23:21:25.596626Z","end":"2026-03-13T23:21:25.705655Z","steps":["trace[723168308] 'agreement among raft nodes before linearized reading' (duration: 108.917957ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:21:25.705919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.677952ms","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-03-13T23:21:25.705957Z","caller":"traceutil/trace.go:171","msg":"trace[2095946693] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7771; }","duration":"108.728042ms","start":"2026-03-13T23:21:25.59722Z","end":"2026-03-13T23:21:25.705948Z","steps":["trace[2095946693] 'agreement among raft nodes before linearized reading' (duration: 108.63116ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:21:25.898674Z","caller":"traceutil/trace.go:171","msg":"trace[1542622454] transaction","detail":"{read_only:false; response_revision:7772; number_of_response:1; }","duration":"187.383306ms","start":"2026-03-13T23:21:25.711Z","end":"2026-03-13T23:21:25.898383Z","steps":["trace[1542622454] 'process raft request' (duration: 187.155911ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:21:25.899157Z","caller":"traceutil/trace.go:171","msg":"trace[28350225] transaction","detail":"{read_only:false; response_revision:7773; number_of_response:1; }","duration":"187.642591ms","start":"2026-03-13T23:21:25.711485Z","end":"2026-03-13T23:21:25.899128Z","steps":["trace[28350225] 'process raft request' (duration: 187.327374ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:21:25.900151Z","caller":"traceutil/trace.go:171","msg":"trace[1566254066] transaction","detail":"{read_only:false; response_revision:7774; number_of_response:1; }","duration":"188.120492ms","start":"2026-03-13T23:21:25.712013Z","end":"2026-03-13T23:21:25.900133Z","steps":["trace[1566254066] 'process raft request' (duration: 187.033776ms)"],"step_count":1} {"level":"warn","ts":"2026-03-13T23:21:38.302898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.199387ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-03-13T23:21:38.303089Z","caller":"traceutil/trace.go:171","msg":"trace[899110363] transaction","detail":"{read_only:false; number_of_response:1; response_revision:7873; }","duration":"135.22403ms","start":"2026-03-13T23:21:38.167847Z","end":"2026-03-13T23:21:38.303071Z","steps":["trace[899110363] 'process raft request' (duration: 27.719896ms)","trace[899110363] 'compare' (duration: 107.091835ms)"],"step_count":2} {"level":"info","ts":"2026-03-13T23:21:38.306879Z","caller":"traceutil/trace.go:171","msg":"trace[299690372] linearizableReadLoop","detail":"{readStateIndex:8177; appliedIndex:8176; }","duration":"100.4766ms","start":"2026-03-13T23:21:38.206388Z","end":"2026-03-13T23:21:38.306865Z","steps":["trace[299690372] 'read index received' (duration: 100.341106ms)","trace[299690372] 'applied index is now lower than readState.Index' (duration: 134.724µs)"],"step_count":2} {"level":"warn","ts":"2026-03-13T23:21:38.307209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.797329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-rn6l2\" ","response":"range_response_count:1 size:4648"} {"level":"info","ts":"2026-03-13T23:21:38.307281Z","caller":"traceutil/trace.go:171","msg":"trace[254804311] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-rn6l2; range_end:; response_count:1; response_revision:7874; }","duration":"100.911731ms","start":"2026-03-13T23:21:38.206353Z","end":"2026-03-13T23:21:38.307265Z","steps":["trace[254804311] 'agreement among raft nodes before linearized reading' (duration: 100.775177ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:21:38.307057Z","caller":"traceutil/trace.go:171","msg":"trace[1217087070] transaction","detail":"{read_only:false; response_revision:7874; number_of_response:1; }","duration":"134.75039ms","start":"2026-03-13T23:21:38.172264Z","end":"2026-03-13T23:21:38.307014Z","steps":["trace[1217087070] 'process raft request' (duration: 134.528484ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:21:39.735918Z","caller":"traceutil/trace.go:171","msg":"trace[1123231598] transaction","detail":"{read_only:false; response_revision:7885; number_of_response:1; }","duration":"154.846808ms","start":"2026-03-13T23:21:39.581044Z","end":"2026-03-13T23:21:39.735891Z","steps":["trace[1123231598] 'process raft request' (duration: 154.661104ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:22:39.991124Z","caller":"traceutil/trace.go:171","msg":"trace[2081316714] transaction","detail":"{read_only:false; response_revision:8507; number_of_response:1; }","duration":"124.387898ms","start":"2026-03-13T23:22:39.866711Z","end":"2026-03-13T23:22:39.991099Z","steps":["trace[2081316714] 'process raft request' (duration: 124.182694ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:22:52.472652Z","caller":"traceutil/trace.go:171","msg":"trace[828790585] transaction","detail":"{read_only:false; response_revision:8569; number_of_response:1; }","duration":"230.123812ms","start":"2026-03-13T23:22:52.242338Z","end":"2026-03-13T23:22:52.472462Z","steps":["trace[828790585] 'process raft request' (duration: 229.947288ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:22:52.47972Z","caller":"traceutil/trace.go:171","msg":"trace[622920296] transaction","detail":"{read_only:false; response_revision:8570; number_of_response:1; }","duration":"222.72004ms","start":"2026-03-13T23:22:52.25698Z","end":"2026-03-13T23:22:52.4797Z","steps":["trace[622920296] 'process raft request' (duration: 222.582297ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:22:52.479906Z","caller":"traceutil/trace.go:171","msg":"trace[433049870] transaction","detail":"{read_only:false; response_revision:8571; number_of_response:1; }","duration":"149.003351ms","start":"2026-03-13T23:22:52.330888Z","end":"2026-03-13T23:22:52.479891Z","steps":["trace[433049870] 'process raft request' (duration: 148.771306ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:22:52.618395Z","caller":"traceutil/trace.go:171","msg":"trace[1785627150] transaction","detail":"{read_only:false; response_revision:8573; number_of_response:1; }","duration":"133.786366ms","start":"2026-03-13T23:22:52.484586Z","end":"2026-03-13T23:22:52.618373Z","steps":["trace[1785627150] 'process raft request' (duration: 133.596192ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:22:52.618568Z","caller":"traceutil/trace.go:171","msg":"trace[113177259] transaction","detail":"{read_only:false; response_revision:8574; number_of_response:1; }","duration":"133.886148ms","start":"2026-03-13T23:22:52.484625Z","end":"2026-03-13T23:22:52.618512Z","steps":["trace[113177259] 'process raft request' (duration: 133.682643ms)"],"step_count":1} {"level":"info","ts":"2026-03-13T23:25:21.208237Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"71d28e9ac1bc4e5d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-03-13T23:25:21.21343Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-03-13T23:25:21.213554Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-03-13T23:26:20.785803Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7701} {"level":"info","ts":"2026-03-13T23:26:20.85245Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7701,"took":"64.056885ms","hash":2272023634,"current-db-size-bytes":42561536,"current-db-size":"43 MB","current-db-size-in-use-bytes":26210304,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-03-13T23:26:20.852522Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2272023634,"revision":7701,"compact-revision":5680} {"level":"info","ts":"2026-03-13T23:31:20.792759Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9942} {"level":"info","ts":"2026-03-13T23:31:20.872832Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9942,"took":"77.001557ms","hash":2040148129,"current-db-size-bytes":42561536,"current-db-size":"43 MB","current-db-size-in-use-bytes":16859136,"current-db-size-in-use":"17 MB"} {"level":"info","ts":"2026-03-13T23:31:20.8729Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2040148129,"revision":9942,"compact-revision":7701}