{"level":"warn","ts":"2026-05-05T06:57:10.352584Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T06:57:10.352708Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.19: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.19:2380","--initial-cluster=instance=https://199.204.45.19:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.19:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.19: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-05-05T06:57:10.352783Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T06:57:10.352792Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-05-05T06:57:10.352822Z","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-05-05T06:57:10.353563Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"]} {"level":"info","ts":"2026-05-05T06:57:10.353659Z","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.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.19: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-05-05T06:57:10.357771Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.915981ms"} {"level":"info","ts":"2026-05-05T06:57:10.363894Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a847c2e9c7010db6","cluster-id":"2b11a68e27507b05"} {"level":"info","ts":"2026-05-05T06:57:10.364003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=()"} {"level":"info","ts":"2026-05-05T06:57:10.364037Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 0"} {"level":"info","ts":"2026-05-05T06:57:10.36406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a847c2e9c7010db6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-05T06:57:10.364074Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 1"} {"level":"info","ts":"2026-05-05T06:57:10.364137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"warn","ts":"2026-05-05T06:57:10.369686Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-05T06:57:10.37122Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-05T06:57:10.372502Z","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-05-05T06:57:10.37583Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a847c2e9c7010db6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-05T06:57:10.376113Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a847c2e9c7010db6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-05T06:57:10.376267Z","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-05-05T06:57:10.376408Z","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-05-05T06:57:10.376427Z","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-05-05T06:57:10.377873Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"info","ts":"2026-05-05T06:57:10.378924Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","added-peer-id":"a847c2e9c7010db6","added-peer-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-05-05T06:57:10.381072Z","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-05-05T06:57:10.381149Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-05-05T06:57:10.381216Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-05-05T06:57:10.381334Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a847c2e9c7010db6","initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-05T06:57:10.381382Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-05T06:57:11.164489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 is starting a new election at term 1"} {"level":"info","ts":"2026-05-05T06:57:11.164557Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-05T06:57:11.164578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgPreVoteResp from a847c2e9c7010db6 at term 1"} {"level":"info","ts":"2026-05-05T06:57:11.164594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became candidate at term 2"} {"level":"info","ts":"2026-05-05T06:57:11.164602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgVoteResp from a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-05-05T06:57:11.164614Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became leader at term 2"} {"level":"info","ts":"2026-05-05T06:57:11.164624Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a847c2e9c7010db6 elected leader a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-05-05T06:57:11.165575Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T06:57:11.166401Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a847c2e9c7010db6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.19:2379]}","request-path":"/0/members/a847c2e9c7010db6/attributes","cluster-id":"2b11a68e27507b05","publish-timeout":"7s"} {"level":"info","ts":"2026-05-05T06:57:11.16642Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T06:57:11.166482Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T06:57:11.16678Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-05T06:57:11.166851Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-05T06:57:11.167552Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T06:57:11.167777Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T06:57:11.167829Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T06:57:11.169026Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.19:2379"} {"level":"info","ts":"2026-05-05T06:57:11.170541Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-05T06:57:34.909776Z","caller":"traceutil/trace.go:171","msg":"trace[1718342852] linearizableReadLoop","detail":"{readStateIndex:440; appliedIndex:439; }","duration":"195.164543ms","start":"2026-05-05T06:57:34.714587Z","end":"2026-05-05T06:57:34.909751Z","steps":["trace[1718342852] 'read index received' (duration: 194.970738ms)","trace[1718342852] 'applied index is now lower than readState.Index' (duration: 192.805µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:57:34.909975Z","caller":"traceutil/trace.go:171","msg":"trace[52723760] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"221.814938ms","start":"2026-05-05T06:57:34.688114Z","end":"2026-05-05T06:57:34.909929Z","steps":["trace[52723760] 'process raft request' (duration: 221.468349ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:57:34.910009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.390379ms","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-05-05T06:57:34.910267Z","caller":"traceutil/trace.go:171","msg":"trace[1283118809] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:422; }","duration":"195.707666ms","start":"2026-05-05T06:57:34.714545Z","end":"2026-05-05T06:57:34.910252Z","steps":["trace[1283118809] 'agreement among raft nodes before linearized reading' (duration: 195.337907ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:57:35.148223Z","caller":"traceutil/trace.go:171","msg":"trace[1491933369] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"233.212174ms","start":"2026-05-05T06:57:34.914779Z","end":"2026-05-05T06:57:35.147991Z","steps":["trace[1491933369] 'process raft request' (duration: 230.530081ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:57:46.771936Z","caller":"traceutil/trace.go:171","msg":"trace[109448354] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"158.827544ms","start":"2026-05-05T06:57:46.613087Z","end":"2026-05-05T06:57:46.771915Z","steps":["trace[109448354] 'process raft request' (duration: 158.362973ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:57:47.403864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.467928ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T06:57:47.404002Z","caller":"traceutil/trace.go:171","msg":"trace[597904246] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:602; }","duration":"199.777542ms","start":"2026-05-05T06:57:47.204209Z","end":"2026-05-05T06:57:47.403987Z","steps":["trace[597904246] 'read index received' (duration: 36.101294ms)","trace[597904246] 'applied index is now lower than readState.Index' (duration: 163.674018ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:57:47.40404Z","caller":"traceutil/trace.go:171","msg":"trace[1028277187] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"435.670237ms","start":"2026-05-05T06:57:46.968338Z","end":"2026-05-05T06:57:47.404008Z","steps":["trace[1028277187] 'process raft request' (duration: 271.961369ms)","trace[1028277187] 'compare' (duration: 162.048339ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:57:47.404167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.956695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-05T06:57:47.40421Z","caller":"traceutil/trace.go:171","msg":"trace[1857387796] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:578; }","duration":"200.046738ms","start":"2026-05-05T06:57:47.204154Z","end":"2026-05-05T06:57:47.404201Z","steps":["trace[1857387796] 'agreement among raft nodes before linearized reading' (duration: 199.915885ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:57:47.404175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:57:46.968316Z","time spent":"435.793939ms","remote":"127.0.0.1:55272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:57:47.405879Z","caller":"traceutil/trace.go:171","msg":"trace[523642174] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"113.469953ms","start":"2026-05-05T06:57:47.29239Z","end":"2026-05-05T06:57:47.40586Z","steps":["trace[523642174] 'process raft request' (duration: 112.886319ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:57:47.405985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.573184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-mtzfz\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-05T06:57:47.406077Z","caller":"traceutil/trace.go:171","msg":"trace[37920820] range","detail":"{range_begin:/registry/pods/kube-system/cilium-mtzfz; range_end:; response_count:1; response_revision:579; }","duration":"136.718097ms","start":"2026-05-05T06:57:47.26934Z","end":"2026-05-05T06:57:47.406058Z","steps":["trace[37920820] 'agreement among raft nodes before linearized reading' (duration: 136.502402ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:58:10.584212Z","caller":"traceutil/trace.go:171","msg":"trace[978395980] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"189.71962ms","start":"2026-05-05T06:58:10.394435Z","end":"2026-05-05T06:58:10.584155Z","steps":["trace[978395980] 'process raft request' (duration: 189.521235ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:59:28.065189Z","caller":"traceutil/trace.go:171","msg":"trace[447255797] linearizableReadLoop","detail":"{readStateIndex:1907; appliedIndex:1906; }","duration":"136.621421ms","start":"2026-05-05T06:59:27.928541Z","end":"2026-05-05T06:59:28.065162Z","steps":["trace[447255797] 'read index received' (duration: 100.777668ms)","trace[447255797] 'applied index is now lower than readState.Index' (duration: 35.842593ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:59:28.065373Z","caller":"traceutil/trace.go:171","msg":"trace[51018647] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"230.569686ms","start":"2026-05-05T06:59:27.834758Z","end":"2026-05-05T06:59:28.065328Z","steps":["trace[51018647] 'process raft request' (duration: 194.639762ms)","trace[51018647] 'compare' (duration: 35.634858ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:59:28.065448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.885176ms","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-05-05T06:59:28.065484Z","caller":"traceutil/trace.go:171","msg":"trace[948647688] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1831; }","duration":"136.987719ms","start":"2026-05-05T06:59:27.928487Z","end":"2026-05-05T06:59:28.065474Z","steps":["trace[948647688] 'agreement among raft nodes before linearized reading' (duration: 136.838795ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:59:41.405904Z","caller":"traceutil/trace.go:171","msg":"trace[1881253481] transaction","detail":"{read_only:false; response_revision:1938; number_of_response:1; }","duration":"152.775624ms","start":"2026-05-05T06:59:41.253108Z","end":"2026-05-05T06:59:41.405884Z","steps":["trace[1881253481] 'process raft request' (duration: 151.605837ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:00:18.77112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.053323ms","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-05-05T07:00:18.771213Z","caller":"traceutil/trace.go:171","msg":"trace[333850744] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2154; }","duration":"114.178875ms","start":"2026-05-05T07:00:18.657018Z","end":"2026-05-05T07:00:18.771197Z","steps":["trace[333850744] 'range keys from in-memory index tree' (duration: 113.874619ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:00:18.954849Z","caller":"traceutil/trace.go:171","msg":"trace[728420452] linearizableReadLoop","detail":"{readStateIndex:2241; appliedIndex:2240; }","duration":"124.10413ms","start":"2026-05-05T07:00:18.830722Z","end":"2026-05-05T07:00:18.954826Z","steps":["trace[728420452] 'read index received' (duration: 123.983337ms)","trace[728420452] 'applied index is now lower than readState.Index' (duration: 119.473µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T07:00:18.954917Z","caller":"traceutil/trace.go:171","msg":"trace[959778278] transaction","detail":"{read_only:false; response_revision:2155; number_of_response:1; }","duration":"180.330854ms","start":"2026-05-05T07:00:18.774552Z","end":"2026-05-05T07:00:18.954883Z","steps":["trace[959778278] 'process raft request' (duration: 180.11331ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:00:18.95498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.235564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T07:00:18.95501Z","caller":"traceutil/trace.go:171","msg":"trace[1750255230] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2155; }","duration":"124.315005ms","start":"2026-05-05T07:00:18.830685Z","end":"2026-05-05T07:00:18.955Z","steps":["trace[1750255230] 'agreement among raft nodes before linearized reading' (duration: 124.228743ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:01:46.935997Z","caller":"traceutil/trace.go:171","msg":"trace[1239621098] linearizableReadLoop","detail":"{readStateIndex:2935; appliedIndex:2934; }","duration":"106.27816ms","start":"2026-05-05T07:01:46.829691Z","end":"2026-05-05T07:01:46.935969Z","steps":["trace[1239621098] 'read index received' (duration: 106.051245ms)","trace[1239621098] 'applied index is now lower than readState.Index' (duration: 226.015µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T07:01:46.93615Z","caller":"traceutil/trace.go:171","msg":"trace[691114546] transaction","detail":"{read_only:false; response_revision:2823; number_of_response:1; }","duration":"116.265516ms","start":"2026-05-05T07:01:46.81987Z","end":"2026-05-05T07:01:46.936135Z","steps":["trace[691114546] 'process raft request' (duration: 115.935629ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:01:46.936499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.738819ms","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-05-05T07:01:46.936606Z","caller":"traceutil/trace.go:171","msg":"trace[1913723012] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2823; }","duration":"106.885683ms","start":"2026-05-05T07:01:46.829695Z","end":"2026-05-05T07:01:46.936581Z","steps":["trace[1913723012] 'agreement among raft nodes before linearized reading' (duration: 106.570956ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:01:46.936792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.070966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-05T07:01:46.937257Z","caller":"traceutil/trace.go:171","msg":"trace[629714786] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2823; }","duration":"107.579207ms","start":"2026-05-05T07:01:46.829656Z","end":"2026-05-05T07:01:46.937236Z","steps":["trace[629714786] 'agreement among raft nodes before linearized reading' (duration: 106.846961ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:01:47.170192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.510934ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T07:01:47.170511Z","caller":"traceutil/trace.go:171","msg":"trace[1684738935] transaction","detail":"{read_only:false; response_revision:2824; number_of_response:1; }","duration":"229.7164ms","start":"2026-05-05T07:01:46.940767Z","end":"2026-05-05T07:01:47.170483Z","steps":["trace[1684738935] 'process raft request' (duration: 92.820488ms)","trace[1684738935] 'compare' (duration: 136.254487ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T07:01:47.170722Z","caller":"traceutil/trace.go:171","msg":"trace[53461500] transaction","detail":"{read_only:false; response_revision:2825; number_of_response:1; }","duration":"229.875744ms","start":"2026-05-05T07:01:46.940821Z","end":"2026-05-05T07:01:47.170697Z","steps":["trace[53461500] 'process raft request' (duration: 229.583856ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:01:47.170826Z","caller":"traceutil/trace.go:171","msg":"trace[1781251330] transaction","detail":"{read_only:false; response_revision:2826; number_of_response:1; }","duration":"229.20744ms","start":"2026-05-05T07:01:46.941594Z","end":"2026-05-05T07:01:47.170801Z","steps":["trace[1781251330] 'process raft request' (duration: 229.053496ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:05:56.073029Z","caller":"traceutil/trace.go:171","msg":"trace[78553237] transaction","detail":"{read_only:false; response_revision:5231; number_of_response:1; }","duration":"130.975903ms","start":"2026-05-05T07:05:55.942028Z","end":"2026-05-05T07:05:56.073004Z","steps":["trace[78553237] 'process raft request' (duration: 130.929722ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:05:56.07334Z","caller":"traceutil/trace.go:171","msg":"trace[435767360] transaction","detail":"{read_only:false; response_revision:5228; number_of_response:1; }","duration":"131.976124ms","start":"2026-05-05T07:05:55.941282Z","end":"2026-05-05T07:05:56.073259Z","steps":["trace[435767360] 'process raft request' (duration: 88.20529ms)","trace[435767360] 'compare' (duration: 43.208502ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T07:05:56.073452Z","caller":"traceutil/trace.go:171","msg":"trace[1724623329] transaction","detail":"{read_only:false; response_revision:5229; number_of_response:1; }","duration":"132.123447ms","start":"2026-05-05T07:05:55.941273Z","end":"2026-05-05T07:05:56.073396Z","steps":["trace[1724623329] 'process raft request' (duration: 131.570285ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:05:56.073477Z","caller":"traceutil/trace.go:171","msg":"trace[478310103] transaction","detail":"{read_only:false; response_revision:5230; number_of_response:1; }","duration":"132.115448ms","start":"2026-05-05T07:05:55.941305Z","end":"2026-05-05T07:05:56.073421Z","steps":["trace[478310103] 'process raft request' (duration: 131.614307ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:06:04.729407Z","caller":"traceutil/trace.go:171","msg":"trace[921024510] linearizableReadLoop","detail":"{readStateIndex:5616; appliedIndex:5615; }","duration":"154.106041ms","start":"2026-05-05T07:06:04.575096Z","end":"2026-05-05T07:06:04.729202Z","steps":["trace[921024510] 'read index received' (duration: 154.028139ms)","trace[921024510] 'applied index is now lower than readState.Index' (duration: 76.632µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T07:06:04.72969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.569321ms","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-05-05T07:06:04.729539Z","caller":"traceutil/trace.go:171","msg":"trace[1978309697] transaction","detail":"{read_only:false; response_revision:5413; number_of_response:1; }","duration":"154.49922ms","start":"2026-05-05T07:06:04.574976Z","end":"2026-05-05T07:06:04.729476Z","steps":["trace[1978309697] 'process raft request' (duration: 154.080551ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:06:04.729773Z","caller":"traceutil/trace.go:171","msg":"trace[252447139] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5413; }","duration":"154.710834ms","start":"2026-05-05T07:06:04.575046Z","end":"2026-05-05T07:06:04.729757Z","steps":["trace[252447139] 'agreement among raft nodes before linearized reading' (duration: 154.475459ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:06:04.754493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.68596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-05T07:06:04.754584Z","caller":"traceutil/trace.go:171","msg":"trace[1031505566] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5414; }","duration":"177.844374ms","start":"2026-05-05T07:06:04.576719Z","end":"2026-05-05T07:06:04.754564Z","steps":["trace[1031505566] 'agreement among raft nodes before linearized reading' (duration: 177.553427ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:06:04.75459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.218748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T07:06:04.75485Z","caller":"traceutil/trace.go:171","msg":"trace[1921263926] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:5414; }","duration":"111.587885ms","start":"2026-05-05T07:06:04.64323Z","end":"2026-05-05T07:06:04.754818Z","steps":["trace[1921263926] 'agreement among raft nodes before linearized reading' (duration: 111.158126ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:06:04.754828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.915365ms","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-05-05T07:06:04.75505Z","caller":"traceutil/trace.go:171","msg":"trace[1358072141] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5414; }","duration":"178.077848ms","start":"2026-05-05T07:06:04.576842Z","end":"2026-05-05T07:06:04.75492Z","steps":["trace[1358072141] 'agreement among raft nodes before linearized reading' (duration: 177.659149ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:06:04.954027Z","caller":"traceutil/trace.go:171","msg":"trace[425475183] transaction","detail":"{read_only:false; response_revision:5416; number_of_response:1; }","duration":"194.620404ms","start":"2026-05-05T07:06:04.75936Z","end":"2026-05-05T07:06:04.953981Z","steps":["trace[425475183] 'process raft request' (duration: 120.576289ms)","trace[425475183] 'compare' (duration: 73.528994ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T07:06:04.954382Z","caller":"traceutil/trace.go:171","msg":"trace[1008213994] transaction","detail":"{read_only:false; response_revision:5417; number_of_response:1; }","duration":"194.367389ms","start":"2026-05-05T07:06:04.759978Z","end":"2026-05-05T07:06:04.954346Z","steps":["trace[1008213994] 'process raft request' (duration: 193.94324ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:06:04.954785Z","caller":"traceutil/trace.go:171","msg":"trace[2076661780] linearizableReadLoop","detail":"{readStateIndex:5620; appliedIndex:5617; }","duration":"193.122092ms","start":"2026-05-05T07:06:04.761622Z","end":"2026-05-05T07:06:04.954744Z","steps":["trace[2076661780] 'read index received' (duration: 10.947656ms)","trace[2076661780] 'applied index is now lower than readState.Index' (duration: 182.171576ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T07:06:04.954824Z","caller":"traceutil/trace.go:171","msg":"trace[840382388] transaction","detail":"{read_only:false; response_revision:5418; number_of_response:1; }","duration":"193.132703ms","start":"2026-05-05T07:06:04.761633Z","end":"2026-05-05T07:06:04.954766Z","steps":["trace[840382388] 'process raft request' (duration: 192.574351ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:06:04.95623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.567704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:80130"} {"level":"info","ts":"2026-05-05T07:06:04.956316Z","caller":"traceutil/trace.go:171","msg":"trace[1331406179] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5418; }","duration":"194.698777ms","start":"2026-05-05T07:06:04.76159Z","end":"2026-05-05T07:06:04.956289Z","steps":["trace[1331406179] 'agreement among raft nodes before linearized reading' (duration: 193.268146ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:06:07.130652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.074724ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-05T07:06:07.130833Z","caller":"traceutil/trace.go:171","msg":"trace[118427770] transaction","detail":"{read_only:false; response_revision:5448; number_of_response:1; }","duration":"132.27287ms","start":"2026-05-05T07:06:06.998515Z","end":"2026-05-05T07:06:07.130788Z","steps":["trace[118427770] 'compare' (duration: 123.626914ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:07:11.197452Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2956} {"level":"info","ts":"2026-05-05T07:07:11.272423Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2956,"took":"73.027929ms","hash":1304513869,"current-db-size-bytes":56938496,"current-db-size":"57 MB","current-db-size-in-use-bytes":33542144,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-05-05T07:07:11.272526Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1304513869,"revision":2956,"compact-revision":-1} {"level":"info","ts":"2026-05-05T07:12:11.205905Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6023} {"level":"info","ts":"2026-05-05T07:12:11.302224Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6023,"took":"93.642434ms","hash":1539826327,"current-db-size-bytes":56938496,"current-db-size":"57 MB","current-db-size-in-use-bytes":23117824,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-05-05T07:12:11.302279Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1539826327,"revision":6023,"compact-revision":2956} {"level":"info","ts":"2026-05-05T07:12:23.11626Z","caller":"traceutil/trace.go:171","msg":"trace[1678806461] transaction","detail":"{read_only:false; response_revision:8307; number_of_response:1; }","duration":"122.073493ms","start":"2026-05-05T07:12:22.99416Z","end":"2026-05-05T07:12:23.116234Z","steps":["trace[1678806461] 'process raft request' (duration: 121.388829ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:12:23.732757Z","caller":"traceutil/trace.go:171","msg":"trace[1303694429] transaction","detail":"{read_only:false; response_revision:8309; number_of_response:1; }","duration":"127.534078ms","start":"2026-05-05T07:12:23.605185Z","end":"2026-05-05T07:12:23.732719Z","steps":["trace[1303694429] 'process raft request' (duration: 86.323276ms)","trace[1303694429] 'compare' (duration: 40.733092ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T07:12:24.427909Z","caller":"traceutil/trace.go:171","msg":"trace[1182089178] linearizableReadLoop","detail":"{readStateIndex:8605; appliedIndex:8604; }","duration":"115.136794ms","start":"2026-05-05T07:12:24.312749Z","end":"2026-05-05T07:12:24.427886Z","steps":["trace[1182089178] 'read index received' (duration: 114.909789ms)","trace[1182089178] 'applied index is now lower than readState.Index' (duration: 225.875µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T07:12:24.427951Z","caller":"traceutil/trace.go:171","msg":"trace[1728006746] transaction","detail":"{read_only:false; response_revision:8311; number_of_response:1; }","duration":"153.079844ms","start":"2026-05-05T07:12:24.274839Z","end":"2026-05-05T07:12:24.427919Z","steps":["trace[1728006746] 'process raft request' (duration: 152.909721ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:12:24.428116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.350488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-05T07:12:24.428165Z","caller":"traceutil/trace.go:171","msg":"trace[990228223] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:1; response_revision:8311; }","duration":"115.44246ms","start":"2026-05-05T07:12:24.312702Z","end":"2026-05-05T07:12:24.428145Z","steps":["trace[990228223] 'agreement among raft nodes before linearized reading' (duration: 115.287517ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:12:24.92352Z","caller":"traceutil/trace.go:171","msg":"trace[299550259] transaction","detail":"{read_only:false; response_revision:8314; number_of_response:1; }","duration":"121.335116ms","start":"2026-05-05T07:12:24.802161Z","end":"2026-05-05T07:12:24.923496Z","steps":["trace[299550259] 'process raft request' (duration: 121.168022ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:12:25.027869Z","caller":"traceutil/trace.go:171","msg":"trace[1767771780] transaction","detail":"{read_only:false; response_revision:8315; number_of_response:1; }","duration":"191.740492ms","start":"2026-05-05T07:12:24.836095Z","end":"2026-05-05T07:12:25.027836Z","steps":["trace[1767771780] 'process raft request' (duration: 119.516197ms)","trace[1767771780] 'compare' (duration: 71.957109ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T07:12:25.189185Z","caller":"traceutil/trace.go:171","msg":"trace[609363331] transaction","detail":"{read_only:false; response_revision:8317; number_of_response:1; }","duration":"155.257681ms","start":"2026-05-05T07:12:25.033897Z","end":"2026-05-05T07:12:25.189155Z","steps":["trace[609363331] 'process raft request' (duration: 146.571865ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:12:52.934115Z","caller":"traceutil/trace.go:171","msg":"trace[1987625377] transaction","detail":"{read_only:false; response_revision:8516; number_of_response:1; }","duration":"134.870785ms","start":"2026-05-05T07:12:52.79921Z","end":"2026-05-05T07:12:52.934081Z","steps":["trace[1987625377] 'process raft request' (duration: 134.647471ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:12:53.147562Z","caller":"traceutil/trace.go:171","msg":"trace[1916981238] transaction","detail":"{read_only:false; response_revision:8517; number_of_response:1; }","duration":"209.477323ms","start":"2026-05-05T07:12:52.938056Z","end":"2026-05-05T07:12:53.147533Z","steps":["trace[1916981238] 'process raft request' (duration: 209.064294ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:13:05.743909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.532837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-lth58\" ","response":"range_response_count:1 size:4644"} {"level":"info","ts":"2026-05-05T07:13:05.744016Z","caller":"traceutil/trace.go:171","msg":"trace[1813947657] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-lth58; range_end:; response_count:1; response_revision:8628; }","duration":"102.723142ms","start":"2026-05-05T07:13:05.641272Z","end":"2026-05-05T07:13:05.743995Z","steps":["trace[1813947657] 'range keys from in-memory index tree' (duration: 102.348174ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:13:05.744066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.663162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xd2fq\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-05-05T07:13:05.744166Z","caller":"traceutil/trace.go:171","msg":"trace[164638954] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xd2fq; range_end:; response_count:1; response_revision:8628; }","duration":"216.817256ms","start":"2026-05-05T07:13:05.527324Z","end":"2026-05-05T07:13:05.744142Z","steps":["trace[164638954] 'range keys from in-memory index tree' (duration: 216.460828ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:13:05.80924Z","caller":"traceutil/trace.go:171","msg":"trace[386853871] transaction","detail":"{read_only:false; response_revision:8629; number_of_response:1; }","duration":"167.531944ms","start":"2026-05-05T07:13:05.641667Z","end":"2026-05-05T07:13:05.809198Z","steps":["trace[386853871] 'process raft request' (duration: 167.246888ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:13:05.878622Z","caller":"traceutil/trace.go:171","msg":"trace[155258246] transaction","detail":"{read_only:false; response_revision:8630; number_of_response:1; }","duration":"124.833463ms","start":"2026-05-05T07:13:05.753739Z","end":"2026-05-05T07:13:05.878572Z","steps":["trace[155258246] 'process raft request' (duration: 116.23677ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:13:06.53404Z","caller":"traceutil/trace.go:171","msg":"trace[494759890] transaction","detail":"{read_only:false; response_revision:8636; number_of_response:1; }","duration":"112.459179ms","start":"2026-05-05T07:13:06.421547Z","end":"2026-05-05T07:13:06.534006Z","steps":["trace[494759890] 'process raft request' (duration: 112.239274ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:13:49.465159Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000247e.wal"} {"level":"warn","ts":"2026-05-05T07:14:22.570168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.32861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xd2fq\" ","response":"range_response_count:1 size:6527"} {"level":"warn","ts":"2026-05-05T07:14:22.570228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.163878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T07:14:22.57034Z","caller":"traceutil/trace.go:171","msg":"trace[2079807097] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xd2fq; range_end:; response_count:1; response_revision:9378; }","duration":"251.533504ms","start":"2026-05-05T07:14:22.318746Z","end":"2026-05-05T07:14:22.57028Z","steps":["trace[2079807097] 'range keys from in-memory index tree' (duration: 250.944201ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:14:22.570357Z","caller":"traceutil/trace.go:171","msg":"trace[394541897] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:9378; }","duration":"101.392482ms","start":"2026-05-05T07:14:22.468931Z","end":"2026-05-05T07:14:22.570323Z","steps":["trace[394541897] 'count revisions from in-memory index tree' (duration: 100.991944ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:14:22.570202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.713899ms","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-05-05T07:14:22.570659Z","caller":"traceutil/trace.go:171","msg":"trace[199474073] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9378; }","duration":"185.19755ms","start":"2026-05-05T07:14:22.38541Z","end":"2026-05-05T07:14:22.570607Z","steps":["trace[199474073] 'range keys from in-memory index tree' (duration: 184.532616ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:15:01.004543Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a847c2e9c7010db6","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-05T07:15:01.00953Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-05-05T07:15:01.009609Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-05-05T07:17:11.213181Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8245} {"level":"info","ts":"2026-05-05T07:17:11.295862Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8245,"took":"80.069762ms","hash":3216344909,"current-db-size-bytes":56938496,"current-db-size":"57 MB","current-db-size-in-use-bytes":26230784,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-05-05T07:17:11.29594Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3216344909,"revision":8245,"compact-revision":6023} {"level":"warn","ts":"2026-05-05T07:18:05.212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.731346ms","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-05-05T07:18:05.212225Z","caller":"traceutil/trace.go:171","msg":"trace[1036166143] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:11221; }","duration":"164.021712ms","start":"2026-05-05T07:18:05.048177Z","end":"2026-05-05T07:18:05.212198Z","steps":["trace[1036166143] 'range keys from in-memory index tree' (duration: 163.45345ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:18:05.219587Z","caller":"traceutil/trace.go:171","msg":"trace[2072155766] transaction","detail":"{read_only:false; response_revision:11222; number_of_response:1; }","duration":"168.623811ms","start":"2026-05-05T07:18:05.050941Z","end":"2026-05-05T07:18:05.219565Z","steps":["trace[2072155766] 'process raft request' (duration: 168.354855ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:18:05.219568Z","caller":"traceutil/trace.go:171","msg":"trace[1213887157] linearizableReadLoop","detail":"{readStateIndex:11605; appliedIndex:11604; }","duration":"161.438738ms","start":"2026-05-05T07:18:05.058093Z","end":"2026-05-05T07:18:05.219532Z","steps":["trace[1213887157] 'read index received' (duration: 161.189243ms)","trace[1213887157] 'applied index is now lower than readState.Index' (duration: 247.725µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T07:18:05.219748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.624622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T07:18:05.219811Z","caller":"traceutil/trace.go:171","msg":"trace[1998673689] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:11222; }","duration":"161.774136ms","start":"2026-05-05T07:18:05.058021Z","end":"2026-05-05T07:18:05.219795Z","steps":["trace[1998673689] 'agreement among raft nodes before linearized reading' (duration: 161.589462ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:18:05.243139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.730497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-05-05T07:18:05.243223Z","caller":"traceutil/trace.go:171","msg":"trace[86068080] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:11223; }","duration":"148.845359ms","start":"2026-05-05T07:18:05.094359Z","end":"2026-05-05T07:18:05.243205Z","steps":["trace[86068080] 'agreement among raft nodes before linearized reading' (duration: 148.502161ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:22:11.220349Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10725} {"level":"info","ts":"2026-05-05T07:22:11.298893Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10725,"took":"75.797683ms","hash":605082594,"current-db-size-bytes":56938496,"current-db-size":"57 MB","current-db-size-in-use-bytes":26939392,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-05-05T07:22:11.298965Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":605082594,"revision":10725,"compact-revision":8245} {"level":"info","ts":"2026-05-05T07:27:11.226222Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12801} {"level":"info","ts":"2026-05-05T07:27:11.303431Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12801,"took":"74.28284ms","hash":3752558655,"current-db-size-bytes":56938496,"current-db-size":"57 MB","current-db-size-in-use-bytes":24182784,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-05-05T07:27:11.303492Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3752558655,"revision":12801,"compact-revision":10725} {"level":"info","ts":"2026-05-05T07:32:11.232213Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14613} {"level":"info","ts":"2026-05-05T07:32:11.305274Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14613,"took":"70.393156ms","hash":2427186362,"current-db-size-bytes":56938496,"current-db-size":"57 MB","current-db-size-in-use-bytes":20369408,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-05-05T07:32:11.305351Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2427186362,"revision":14613,"compact-revision":12801} {"level":"info","ts":"2026-05-05T07:37:11.237255Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16137} {"level":"info","ts":"2026-05-05T07:37:11.302664Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16137,"took":"62.953143ms","hash":335366528,"current-db-size-bytes":56938496,"current-db-size":"57 MB","current-db-size-in-use-bytes":20283392,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-05-05T07:37:11.30274Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":335366528,"revision":16137,"compact-revision":14613}