{"level":"warn","ts":"2026-03-09T10:15:42.310065Z","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-09T10:15:42.310145Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.131: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.131:2380","--initial-cluster=instance=https://199.204.45.131:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.131:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.131: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-09T10:15:42.310206Z","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-09T10:15:42.310215Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.131:2380"]}
{"level":"info","ts":"2026-03-09T10:15:42.310233Z","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-09T10:15:42.310913Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.131:2379"]}
{"level":"info","ts":"2026-03-09T10:15:42.311006Z","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.131:2380"],"listen-peer-urls":["https://199.204.45.131:2380"],"advertise-client-urls":["https://199.204.45.131:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.131:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.131: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-09T10:15:42.314896Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.701932ms"}
{"level":"info","ts":"2026-03-09T10:15:42.3205Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2fdf33955ed9ec6c","cluster-id":"e3dd6b4ed8cb907a"}
{"level":"info","ts":"2026-03-09T10:15:42.320598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c switched to configuration voters=()"}
{"level":"info","ts":"2026-03-09T10:15:42.320622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c became follower at term 0"}
{"level":"info","ts":"2026-03-09T10:15:42.32064Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2fdf33955ed9ec6c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-09T10:15:42.320654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c became follower at term 1"}
{"level":"info","ts":"2026-03-09T10:15:42.320693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c switched to configuration voters=(3449532556223573100)"}
{"level":"warn","ts":"2026-03-09T10:15:42.326814Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-09T10:15:42.328418Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-09T10:15:42.329476Z","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-09T10:15:42.331632Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2fdf33955ed9ec6c","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-09T10:15:42.331805Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2fdf33955ed9ec6c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-09T10:15:42.331914Z","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-09T10:15:42.332037Z","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-09T10:15:42.332066Z","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-09T10:15:42.333898Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c switched to configuration voters=(3449532556223573100)"}
{"level":"info","ts":"2026-03-09T10:15:42.334668Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e3dd6b4ed8cb907a","local-member-id":"2fdf33955ed9ec6c","added-peer-id":"2fdf33955ed9ec6c","added-peer-peer-urls":["https://199.204.45.131:2380"]}
{"level":"info","ts":"2026-03-09T10:15:42.337211Z","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-09T10:15:42.337488Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.131:2380"}
{"level":"info","ts":"2026-03-09T10:15:42.337593Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.131:2380"}
{"level":"info","ts":"2026-03-09T10:15:42.338304Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-09T10:15:42.338253Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2fdf33955ed9ec6c","initial-advertise-peer-urls":["https://199.204.45.131:2380"],"listen-peer-urls":["https://199.204.45.131:2380"],"advertise-client-urls":["https://199.204.45.131:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.131:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-09T10:15:43.321241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c is starting a new election at term 1"}
{"level":"info","ts":"2026-03-09T10:15:43.321303Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-09T10:15:43.321351Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c received MsgPreVoteResp from 2fdf33955ed9ec6c at term 1"}
{"level":"info","ts":"2026-03-09T10:15:43.321371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c became candidate at term 2"}
{"level":"info","ts":"2026-03-09T10:15:43.321382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c received MsgVoteResp from 2fdf33955ed9ec6c at term 2"}
{"level":"info","ts":"2026-03-09T10:15:43.321398Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c became leader at term 2"}
{"level":"info","ts":"2026-03-09T10:15:43.321411Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2fdf33955ed9ec6c elected leader 2fdf33955ed9ec6c at term 2"}
{"level":"info","ts":"2026-03-09T10:15:43.322587Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-09T10:15:43.323845Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2fdf33955ed9ec6c","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.131:2379]}","request-path":"/0/members/2fdf33955ed9ec6c/attributes","cluster-id":"e3dd6b4ed8cb907a","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-09T10:15:43.323948Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-09T10:15:43.323968Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-09T10:15:43.324235Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-09T10:15:43.32433Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-09T10:15:43.324485Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e3dd6b4ed8cb907a","local-member-id":"2fdf33955ed9ec6c","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-09T10:15:43.324623Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-09T10:15:43.324665Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-09T10:15:43.327325Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-09T10:15:43.327747Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.131:2379"}
{"level":"info","ts":"2026-03-09T10:16:20.745914Z","caller":"traceutil/trace.go:171","msg":"trace[700327880] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"356.741309ms","start":"2026-03-09T10:16:20.389141Z","end":"2026-03-09T10:16:20.745882Z","steps":["trace[700327880] 'process raft request'  (duration: 356.518535ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T10:16:20.746687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T10:16:20.389106Z","time spent":"356.925863ms","remote":"127.0.0.1:49932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-ft9jf\" mod_revision:460 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-ft9jf\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-ft9jf\" > >"}
{"level":"info","ts":"2026-03-09T10:17:42.635124Z","caller":"traceutil/trace.go:171","msg":"trace[527612649] transaction","detail":"{read_only:false; response_revision:1599; number_of_response:1; }","duration":"163.195488ms","start":"2026-03-09T10:17:42.471906Z","end":"2026-03-09T10:17:42.635101Z","steps":["trace[527612649] 'process raft request'  (duration: 163.051285ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T10:17:55.633132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.217058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-03-09T10:17:55.633263Z","caller":"traceutil/trace.go:171","msg":"trace[1105902811] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1702; }","duration":"132.384222ms","start":"2026-03-09T10:17:55.500857Z","end":"2026-03-09T10:17:55.633241Z","steps":["trace[1105902811] 'range keys from in-memory index tree'  (duration: 132.032235ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T10:17:55.63325Z","caller":"traceutil/trace.go:171","msg":"trace[1104966278] linearizableReadLoop","detail":"{readStateIndex:1771; appliedIndex:1770; }","duration":"104.593794ms","start":"2026-03-09T10:17:55.528626Z","end":"2026-03-09T10:17:55.63322Z","steps":["trace[1104966278] 'read index received'  (duration: 17.355486ms)","trace[1104966278] 'applied index is now lower than readState.Index'  (duration: 87.237328ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T10:17:55.633356Z","caller":"traceutil/trace.go:171","msg":"trace[1473158045] transaction","detail":"{read_only:false; response_revision:1703; number_of_response:1; }","duration":"127.752202ms","start":"2026-03-09T10:17:55.505573Z","end":"2026-03-09T10:17:55.633326Z","steps":["trace[1473158045] 'process raft request'  (duration: 40.503334ms)","trace[1473158045] 'compare'  (duration: 86.995323ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T10:17:55.633541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.90428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-messaging-topology-operator-6f465c979f-l927w\" ","response":"range_response_count:1 size:6144"}
{"level":"info","ts":"2026-03-09T10:17:55.633619Z","caller":"traceutil/trace.go:171","msg":"trace[1017231782] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-messaging-topology-operator-6f465c979f-l927w; range_end:; response_count:1; response_revision:1703; }","duration":"105.034413ms","start":"2026-03-09T10:17:55.528563Z","end":"2026-03-09T10:17:55.633598Z","steps":["trace[1017231782] 'agreement among raft nodes before linearized reading'  (duration: 104.822619ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T10:18:31.886221Z","caller":"traceutil/trace.go:171","msg":"trace[1405203284] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"125.326024ms","start":"2026-03-09T10:18:31.760863Z","end":"2026-03-09T10:18:31.886189Z","steps":["trace[1405203284] 'process raft request'  (duration: 47.977498ms)","trace[1405203284] 'compare'  (duration: 77.109772ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T10:18:38.047079Z","caller":"traceutil/trace.go:171","msg":"trace[1197255173] transaction","detail":"{read_only:false; response_revision:1924; number_of_response:1; }","duration":"142.251822ms","start":"2026-03-09T10:18:37.904801Z","end":"2026-03-09T10:18:38.047053Z","steps":["trace[1197255173] 'process raft request'  (duration: 142.078248ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T10:18:38.396497Z","caller":"traceutil/trace.go:171","msg":"trace[711929743] linearizableReadLoop","detail":"{readStateIndex:2003; appliedIndex:2001; }","duration":"440.641693ms","start":"2026-03-09T10:18:37.955823Z","end":"2026-03-09T10:18:38.396464Z","steps":["trace[711929743] 'read index received'  (duration: 91.080342ms)","trace[711929743] 'applied index is now lower than readState.Index'  (duration: 349.559831ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T10:18:38.396588Z","caller":"traceutil/trace.go:171","msg":"trace[1400055652] transaction","detail":"{read_only:false; response_revision:1925; number_of_response:1; }","duration":"471.837437ms","start":"2026-03-09T10:18:37.9247Z","end":"2026-03-09T10:18:38.396537Z","steps":["trace[1400055652] 'process raft request'  (duration: 418.990635ms)","trace[1400055652] 'compare'  (duration: 52.577356ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T10:18:38.39678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T10:18:37.924684Z","time spent":"471.99748ms","remote":"127.0.0.1:50022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1876 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-03-09T10:18:38.396843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.0136ms","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-09T10:18:38.396868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.135175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-03-09T10:18:38.396915Z","caller":"traceutil/trace.go:171","msg":"trace[1817809736] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1925; }","duration":"441.135983ms","start":"2026-03-09T10:18:37.955757Z","end":"2026-03-09T10:18:38.396893Z","steps":["trace[1817809736] 'agreement among raft nodes before linearized reading'  (duration: 440.850928ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T10:18:38.396964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T10:18:37.955736Z","time spent":"441.215944ms","remote":"127.0.0.1:50022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-09T10:18:38.396962Z","caller":"traceutil/trace.go:171","msg":"trace[1341907443] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1925; }","duration":"421.281458ms","start":"2026-03-09T10:18:37.975655Z","end":"2026-03-09T10:18:38.396937Z","steps":["trace[1341907443] 'agreement among raft nodes before linearized reading'  (duration: 421.019443ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T10:18:38.397014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T10:18:37.975633Z","time spent":"421.369669ms","remote":"127.0.0.1:37048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-03-09T10:18:38.397034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.678573ms","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-03-09T10:18:38.397276Z","caller":"traceutil/trace.go:171","msg":"trace[16783037] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1925; }","duration":"409.967109ms","start":"2026-03-09T10:18:37.987285Z","end":"2026-03-09T10:18:38.397252Z","steps":["trace[16783037] 'agreement among raft nodes before linearized reading'  (duration: 409.627483ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T10:18:38.397558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T10:18:37.987261Z","time spent":"410.109382ms","remote":"127.0.0.1:50022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-09T10:18:38.620656Z","caller":"traceutil/trace.go:171","msg":"trace[648080660] transaction","detail":"{read_only:false; response_revision:1927; number_of_response:1; }","duration":"218.997065ms","start":"2026-03-09T10:18:38.40164Z","end":"2026-03-09T10:18:38.620637Z","steps":["trace[648080660] 'process raft request'  (duration: 218.868993ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T10:18:38.620652Z","caller":"traceutil/trace.go:171","msg":"trace[1892217995] transaction","detail":"{read_only:false; response_revision:1926; number_of_response:1; }","duration":"220.656949ms","start":"2026-03-09T10:18:38.399944Z","end":"2026-03-09T10:18:38.620601Z","steps":["trace[1892217995] 'process raft request'  (duration: 146.32116ms)","trace[1892217995] 'compare'  (duration: 74.124975ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T10:18:38.62078Z","caller":"traceutil/trace.go:171","msg":"trace[1531539525] transaction","detail":"{read_only:false; response_revision:1928; number_of_response:1; }","duration":"219.003805ms","start":"2026-03-09T10:18:38.401737Z","end":"2026-03-09T10:18:38.620741Z","steps":["trace[1531539525] 'process raft request'  (duration: 218.866283ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T10:19:19.005585Z","caller":"traceutil/trace.go:171","msg":"trace[1931974326] transaction","detail":"{read_only:false; response_revision:2296; number_of_response:1; }","duration":"198.372647ms","start":"2026-03-09T10:19:18.807174Z","end":"2026-03-09T10:19:19.005547Z","steps":["trace[1931974326] 'process raft request'  (duration: 198.130852ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T10:19:19.020791Z","caller":"traceutil/trace.go:171","msg":"trace[1417399] transaction","detail":"{read_only:false; response_revision:2297; number_of_response:1; }","duration":"213.5531ms","start":"2026-03-09T10:19:18.807211Z","end":"2026-03-09T10:19:19.020764Z","steps":["trace[1417399] 'process raft request'  (duration: 213.442008ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T10:19:53.306906Z","caller":"traceutil/trace.go:171","msg":"trace[1119968976] transaction","detail":"{read_only:false; response_revision:2490; number_of_response:1; }","duration":"122.23565ms","start":"2026-03-09T10:19:53.184647Z","end":"2026-03-09T10:19:53.306882Z","steps":["trace[1119968976] 'process raft request'  (duration: 122.199619ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T10:19:53.30696Z","caller":"traceutil/trace.go:171","msg":"trace[71532221] transaction","detail":"{read_only:false; response_revision:2489; number_of_response:1; }","duration":"128.280308ms","start":"2026-03-09T10:19:53.178656Z","end":"2026-03-09T10:19:53.306936Z","steps":["trace[71532221] 'process raft request'  (duration: 128.148884ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T10:19:53.306947Z","caller":"traceutil/trace.go:171","msg":"trace[1886559643] transaction","detail":"{read_only:false; response_revision:2488; number_of_response:1; }","duration":"142.678279ms","start":"2026-03-09T10:19:53.164227Z","end":"2026-03-09T10:19:53.306905Z","steps":["trace[1886559643] 'process raft request'  (duration: 135.951497ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T10:23:44.462426Z","caller":"traceutil/trace.go:171","msg":"trace[317726623] transaction","detail":"{read_only:false; number_of_response:0; response_revision:4550; }","duration":"122.595273ms","start":"2026-03-09T10:23:44.339795Z","end":"2026-03-09T10:23:44.46239Z","steps":["trace[317726623] 'process raft request'  (duration: 122.377528ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T10:23:44.638545Z","caller":"traceutil/trace.go:171","msg":"trace[124236913] transaction","detail":"{read_only:false; response_revision:4554; number_of_response:1; }","duration":"166.828495ms","start":"2026-03-09T10:23:44.471698Z","end":"2026-03-09T10:23:44.638526Z","steps":["trace[124236913] 'process raft request'  (duration: 166.790905ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T10:23:44.638699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.662879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-tnfn7\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-03-09T10:23:44.638731Z","caller":"traceutil/trace.go:171","msg":"trace[1503296095] range","detail":"{range_begin:/registry/pods/openstack/keepalived-tnfn7; range_end:; response_count:1; response_revision:4554; }","duration":"132.735411ms","start":"2026-03-09T10:23:44.505989Z","end":"2026-03-09T10:23:44.638724Z","steps":["trace[1503296095] 'agreement among raft nodes before linearized reading'  (duration: 132.595188ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T10:23:44.63856Z","caller":"traceutil/trace.go:171","msg":"trace[677430786] linearizableReadLoop","detail":"{readStateIndex:4737; appliedIndex:4737; }","duration":"132.528007ms","start":"2026-03-09T10:23:44.506023Z","end":"2026-03-09T10:23:44.638551Z","steps":["trace[677430786] 'read index received'  (duration: 132.521417ms)","trace[677430786] 'applied index is now lower than readState.Index'  (duration: 5.47µs)"],"step_count":2}
{"level":"info","ts":"2026-03-09T10:23:44.638813Z","caller":"traceutil/trace.go:171","msg":"trace[128685196] transaction","detail":"{read_only:false; response_revision:4553; number_of_response:1; }","duration":"169.815634ms","start":"2026-03-09T10:23:44.468958Z","end":"2026-03-09T10:23:44.638773Z","steps":["trace[128685196] 'process raft request'  (duration: 169.494188ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T10:23:44.638929Z","caller":"traceutil/trace.go:171","msg":"trace[1080926598] transaction","detail":"{read_only:false; response_revision:4552; number_of_response:1; }","duration":"170.559268ms","start":"2026-03-09T10:23:44.46836Z","end":"2026-03-09T10:23:44.638919Z","steps":["trace[1080926598] 'process raft request'  (duration: 169.974747ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T10:23:45.063531Z","caller":"traceutil/trace.go:171","msg":"trace[728168043] transaction","detail":"{read_only:false; response_revision:4568; number_of_response:1; }","duration":"228.782043ms","start":"2026-03-09T10:23:44.83472Z","end":"2026-03-09T10:23:45.063502Z","steps":["trace[728168043] 'process raft request'  (duration: 195.164228ms)","trace[728168043] 'compare'  (duration: 33.459342ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T10:23:53.42208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.589035ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17036163916602677669 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/services/specs/openstack/memcached-metrics\" mod_revision:0 > success:<request_put:<key:\"/registry/services/specs/openstack/memcached-metrics\" value_size:690 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-09T10:23:53.422352Z","caller":"traceutil/trace.go:171","msg":"trace[571109961] transaction","detail":"{read_only:false; response_revision:4715; number_of_response:1; }","duration":"143.099253ms","start":"2026-03-09T10:23:53.279197Z","end":"2026-03-09T10:23:53.422296Z","steps":["trace[571109961] 'process raft request'  (duration: 25.014509ms)","trace[571109961] 'compare'  (duration: 117.39544ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T10:23:53.422713Z","caller":"traceutil/trace.go:171","msg":"trace[294440056] transaction","detail":"{read_only:false; response_revision:4716; number_of_response:1; }","duration":"105.902375ms","start":"2026-03-09T10:23:53.316797Z","end":"2026-03-09T10:23:53.422699Z","steps":["trace[294440056] 'process raft request'  (duration: 105.390305ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T10:23:53.771942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.7517ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17036163916602677680 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-503fb392-9cc9-4b89-ba84-62f152194596\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-503fb392-9cc9-4b89-ba84-62f152194596\" value_size:2420 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-09T10:23:53.77204Z","caller":"traceutil/trace.go:171","msg":"trace[592993245] linearizableReadLoop","detail":"{readStateIndex:4910; appliedIndex:4909; }","duration":"243.688705ms","start":"2026-03-09T10:23:53.528336Z","end":"2026-03-09T10:23:53.772024Z","steps":["trace[592993245] 'read index received'  (duration: 8.813632ms)","trace[592993245] 'applied index is now lower than readState.Index'  (duration: 234.873733ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T10:23:53.772203Z","caller":"traceutil/trace.go:171","msg":"trace[645266624] transaction","detail":"{read_only:false; response_revision:4723; number_of_response:1; }","duration":"297.825321ms","start":"2026-03-09T10:23:53.474366Z","end":"2026-03-09T10:23:53.772192Z","steps":["trace[645266624] 'process raft request'  (duration: 62.758284ms)","trace[645266624] 'compare'  (duration: 234.453255ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T10:23:53.772434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.49842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-09T10:23:53.772484Z","caller":"traceutil/trace.go:171","msg":"trace[1393518299] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4723; }","duration":"226.587141ms","start":"2026-03-09T10:23:53.545884Z","end":"2026-03-09T10:23:53.772471Z","steps":["trace[1393518299] 'agreement among raft nodes before linearized reading'  (duration: 226.433918ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T10:23:53.77249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.130794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T10:23:53.772577Z","caller":"traceutil/trace.go:171","msg":"trace[253362537] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4723; }","duration":"244.258746ms","start":"2026-03-09T10:23:53.528298Z","end":"2026-03-09T10:23:53.772556Z","steps":["trace[253362537] 'agreement among raft nodes before linearized reading'  (duration: 244.103523ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T10:24:03.965113Z","caller":"traceutil/trace.go:171","msg":"trace[1717447738] transaction","detail":"{read_only:false; response_revision:4957; number_of_response:1; }","duration":"110.321316ms","start":"2026-03-09T10:24:03.854767Z","end":"2026-03-09T10:24:03.965089Z","steps":["trace[1717447738] 'process raft request'  (duration: 110.1297ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T10:24:13.713347Z","caller":"traceutil/trace.go:171","msg":"trace[1410386397] transaction","detail":"{read_only:false; response_revision:5069; number_of_response:1; }","duration":"123.392754ms","start":"2026-03-09T10:24:13.589929Z","end":"2026-03-09T10:24:13.713321Z","steps":["trace[1410386397] 'process raft request'  (duration: 123.287251ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T10:25:43.361646Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2736}
{"level":"info","ts":"2026-03-09T10:25:43.415469Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2736,"took":"52.272278ms","hash":1587318672,"current-db-size-bytes":41230336,"current-db-size":"41 MB","current-db-size-in-use-bytes":30949376,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-03-09T10:25:43.415548Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1587318672,"revision":2736,"compact-revision":-1}
{"level":"warn","ts":"2026-03-09T10:30:13.088218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.609775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T10:30:13.088327Z","caller":"traceutil/trace.go:171","msg":"trace[328814153] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:7587; }","duration":"232.749198ms","start":"2026-03-09T10:30:12.855558Z","end":"2026-03-09T10:30:13.088307Z","steps":["trace[328814153] 'count revisions from in-memory index tree'  (duration: 232.509734ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T10:30:13.088306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.83021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-tnfn7\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-03-09T10:30:13.08839Z","caller":"traceutil/trace.go:171","msg":"trace[1107688325] range","detail":"{range_begin:/registry/pods/openstack/keepalived-tnfn7; range_end:; response_count:1; response_revision:7587; }","duration":"242.993643ms","start":"2026-03-09T10:30:12.845375Z","end":"2026-03-09T10:30:13.088368Z","steps":["trace[1107688325] 'range keys from in-memory index tree'  (duration: 242.618825ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T10:30:26.748077Z","caller":"traceutil/trace.go:171","msg":"trace[879466909] linearizableReadLoop","detail":"{readStateIndex:7936; appliedIndex:7935; }","duration":"103.550258ms","start":"2026-03-09T10:30:26.644502Z","end":"2026-03-09T10:30:26.748053Z","steps":["trace[879466909] 'read index received'  (duration: 103.468477ms)","trace[879466909] 'applied index is now lower than readState.Index'  (duration: 80.151µs)"],"step_count":2}
{"level":"info","ts":"2026-03-09T10:30:26.748188Z","caller":"traceutil/trace.go:171","msg":"trace[1471165654] transaction","detail":"{read_only:false; response_revision:7651; number_of_response:1; }","duration":"122.315822ms","start":"2026-03-09T10:30:26.625834Z","end":"2026-03-09T10:30:26.74815Z","steps":["trace[1471165654] 'process raft request'  (duration: 122.031566ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T10:30:26.748345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.820523ms","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-09T10:30:26.748413Z","caller":"traceutil/trace.go:171","msg":"trace[1769169083] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7651; }","duration":"103.942606ms","start":"2026-03-09T10:30:26.644452Z","end":"2026-03-09T10:30:26.748395Z","steps":["trace[1769169083] 'agreement among raft nodes before linearized reading'  (duration: 103.731152ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T10:30:26.762434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.828154ms","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-09T10:30:26.762491Z","caller":"traceutil/trace.go:171","msg":"trace[189066787] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7652; }","duration":"108.930296ms","start":"2026-03-09T10:30:26.653548Z","end":"2026-03-09T10:30:26.762478Z","steps":["trace[189066787] 'agreement among raft nodes before linearized reading'  (duration: 108.750373ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T10:30:43.36909Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5714}
{"level":"info","ts":"2026-03-09T10:30:43.467742Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5714,"took":"96.490068ms","hash":334590588,"current-db-size-bytes":42393600,"current-db-size":"42 MB","current-db-size-in-use-bytes":23404544,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-03-09T10:30:43.467831Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":334590588,"revision":5714,"compact-revision":2736}
{"level":"info","ts":"2026-03-09T10:30:53.668767Z","caller":"traceutil/trace.go:171","msg":"trace[923949099] linearizableReadLoop","detail":"{readStateIndex:8133; appliedIndex:8132; }","duration":"144.871574ms","start":"2026-03-09T10:30:53.523872Z","end":"2026-03-09T10:30:53.668744Z","steps":["trace[923949099] 'read index received'  (duration: 144.67621ms)","trace[923949099] 'applied index is now lower than readState.Index'  (duration: 194.074µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T10:30:53.669529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.640209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T10:30:53.669562Z","caller":"traceutil/trace.go:171","msg":"trace[1600476845] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7840; }","duration":"145.71715ms","start":"2026-03-09T10:30:53.523835Z","end":"2026-03-09T10:30:53.669552Z","steps":["trace[1600476845] 'agreement among raft nodes before linearized reading'  (duration: 145.614808ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T10:30:53.669944Z","caller":"traceutil/trace.go:171","msg":"trace[1612334621] transaction","detail":"{read_only:false; response_revision:7840; number_of_response:1; }","duration":"215.548054ms","start":"2026-03-09T10:30:53.454376Z","end":"2026-03-09T10:30:53.669924Z","steps":["trace[1612334621] 'process raft request'  (duration: 214.241258ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T10:30:53.834076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.658518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T10:30:53.834146Z","caller":"traceutil/trace.go:171","msg":"trace[1641512398] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7840; }","duration":"160.76411ms","start":"2026-03-09T10:30:53.673366Z","end":"2026-03-09T10:30:53.83413Z","steps":["trace[1641512398] 'range keys from in-memory index tree'  (duration: 160.598147ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T10:30:57.037829Z","caller":"traceutil/trace.go:171","msg":"trace[834910384] linearizableReadLoop","detail":"{readStateIndex:8148; appliedIndex:8147; }","duration":"153.479086ms","start":"2026-03-09T10:30:56.884328Z","end":"2026-03-09T10:30:57.037807Z","steps":["trace[834910384] 'read index received'  (duration: 153.313442ms)","trace[834910384] 'applied index is now lower than readState.Index'  (duration: 164.884µs)"],"step_count":2}
{"level":"info","ts":"2026-03-09T10:30:57.037862Z","caller":"traceutil/trace.go:171","msg":"trace[1649717441] transaction","detail":"{read_only:false; response_revision:7854; number_of_response:1; }","duration":"183.026906ms","start":"2026-03-09T10:30:56.854819Z","end":"2026-03-09T10:30:57.037845Z","steps":["trace[1649717441] 'process raft request'  (duration: 182.866213ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T10:30:57.038016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.677919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-03-09T10:30:57.038059Z","caller":"traceutil/trace.go:171","msg":"trace[1156130083] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7854; }","duration":"153.761091ms","start":"2026-03-09T10:30:56.884288Z","end":"2026-03-09T10:30:57.038049Z","steps":["trace[1156130083] 'agreement among raft nodes before linearized reading'  (duration: 153.629589ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T10:30:57.038138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.6551ms","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-09T10:30:57.038182Z","caller":"traceutil/trace.go:171","msg":"trace[151759553] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7854; }","duration":"123.746492ms","start":"2026-03-09T10:30:56.914424Z","end":"2026-03-09T10:30:57.038171Z","steps":["trace[151759553] 'agreement among raft nodes before linearized reading'  (duration: 123.592349ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T10:30:57.038509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.838383ms","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-09T10:30:57.038607Z","caller":"traceutil/trace.go:171","msg":"trace[1125562526] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7854; }","duration":"148.982725ms","start":"2026-03-09T10:30:56.889596Z","end":"2026-03-09T10:30:57.038578Z","steps":["trace[1125562526] 'agreement among raft nodes before linearized reading'  (duration: 148.427764ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T10:31:06.363893Z","caller":"traceutil/trace.go:171","msg":"trace[327057094] transaction","detail":"{read_only:false; response_revision:7945; number_of_response:1; }","duration":"101.887686ms","start":"2026-03-09T10:31:06.261974Z","end":"2026-03-09T10:31:06.363862Z","steps":["trace[327057094] 'process raft request'  (duration: 101.725542ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T10:31:06.368962Z","caller":"traceutil/trace.go:171","msg":"trace[1593464209] linearizableReadLoop","detail":"{readStateIndex:8245; appliedIndex:8244; }","duration":"106.562308ms","start":"2026-03-09T10:31:06.262369Z","end":"2026-03-09T10:31:06.368931Z","steps":["trace[1593464209] 'read index received'  (duration: 101.587399ms)","trace[1593464209] 'applied index is now lower than readState.Index'  (duration: 4.973569ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T10:31:06.369122Z","caller":"traceutil/trace.go:171","msg":"trace[1867351841] transaction","detail":"{read_only:false; response_revision:7946; number_of_response:1; }","duration":"107.069399ms","start":"2026-03-09T10:31:06.262033Z","end":"2026-03-09T10:31:06.369102Z","steps":["trace[1867351841] 'process raft request'  (duration: 106.755993ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T10:31:06.369557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.17026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-mmsk8\" ","response":"range_response_count:1 size:4653"}
{"level":"info","ts":"2026-03-09T10:31:06.369625Z","caller":"traceutil/trace.go:171","msg":"trace[973374077] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-mmsk8; range_end:; response_count:1; response_revision:7946; }","duration":"107.315452ms","start":"2026-03-09T10:31:06.262292Z","end":"2026-03-09T10:31:06.369608Z","steps":["trace[973374077] 'agreement among raft nodes before linearized reading'  (duration: 107.170259ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T10:32:22.211887Z","caller":"traceutil/trace.go:171","msg":"trace[624331157] transaction","detail":"{read_only:false; response_revision:8653; number_of_response:1; }","duration":"105.93026ms","start":"2026-03-09T10:32:22.105929Z","end":"2026-03-09T10:32:22.21186Z","steps":["trace[624331157] 'process raft request'  (duration: 105.709756ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T10:34:42.653189Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"2fdf33955ed9ec6c","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-03-09T10:34:42.658634Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-03-09T10:34:42.658762Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-03-09T10:35:43.374515Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7737}
{"level":"info","ts":"2026-03-09T10:35:43.465531Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7737,"took":"88.881363ms","hash":2107792067,"current-db-size-bytes":42393600,"current-db-size":"42 MB","current-db-size-in-use-bytes":26402816,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-03-09T10:35:43.465625Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2107792067,"revision":7737,"compact-revision":5714}
{"level":"info","ts":"2026-03-09T10:40:43.381164Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9984}
{"level":"info","ts":"2026-03-09T10:40:43.459921Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9984,"took":"76.634405ms","hash":3261268338,"current-db-size-bytes":42393600,"current-db-size":"42 MB","current-db-size-in-use-bytes":17014784,"current-db-size-in-use":"17 MB"}
{"level":"info","ts":"2026-03-09T10:40:43.460002Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3261268338,"revision":9984,"compact-revision":7737}