{"level":"warn","ts":"2026-03-19T13:35:36.359739Z","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-19T13:35:36.35983Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.205:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.205:2380","--initial-cluster=instance=https://199.204.45.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.205:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-03-19T13:35:36.359895Z","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-19T13:35:36.359904Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.205:2380"]}
{"level":"info","ts":"2026-03-19T13:35:36.359919Z","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-19T13:35:36.360537Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"]}
{"level":"info","ts":"2026-03-19T13:35:36.360611Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.205:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-03-19T13:35:36.365547Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.739122ms"}
{"level":"info","ts":"2026-03-19T13:35:36.377495Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"71d28e9ac1bc4e5d","cluster-id":"4a4ae660c7a9a6a7"}
{"level":"info","ts":"2026-03-19T13:35:36.377571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=()"}
{"level":"info","ts":"2026-03-19T13:35:36.377596Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 0"}
{"level":"info","ts":"2026-03-19T13:35:36.377606Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 71d28e9ac1bc4e5d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-19T13:35:36.377619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 1"}
{"level":"info","ts":"2026-03-19T13:35:36.37767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"}
{"level":"warn","ts":"2026-03-19T13:35:36.384296Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-19T13:35:36.388013Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-19T13:35:36.390267Z","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-19T13:35:36.392974Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"71d28e9ac1bc4e5d","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-19T13:35:36.393231Z","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-19T13:35:36.393333Z","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-19T13:35:36.393352Z","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-19T13:35:36.393261Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"71d28e9ac1bc4e5d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-19T13:35:36.394495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"}
{"level":"info","ts":"2026-03-19T13:35:36.394659Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","added-peer-id":"71d28e9ac1bc4e5d","added-peer-peer-urls":["https://199.204.45.205:2380"]}
{"level":"info","ts":"2026-03-19T13:35:36.396509Z","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-19T13:35:36.396652Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.205:2380"}
{"level":"info","ts":"2026-03-19T13:35:36.396678Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.205:2380"}
{"level":"info","ts":"2026-03-19T13:35:36.39686Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"71d28e9ac1bc4e5d","initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-19T13:35:36.396907Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-19T13:35:37.178376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d is starting a new election at term 1"}
{"level":"info","ts":"2026-03-19T13:35:37.178473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-19T13:35:37.17852Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgPreVoteResp from 71d28e9ac1bc4e5d at term 1"}
{"level":"info","ts":"2026-03-19T13:35:37.17854Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became candidate at term 2"}
{"level":"info","ts":"2026-03-19T13:35:37.178551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgVoteResp from 71d28e9ac1bc4e5d at term 2"}
{"level":"info","ts":"2026-03-19T13:35:37.178579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became leader at term 2"}
{"level":"info","ts":"2026-03-19T13:35:37.178593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 71d28e9ac1bc4e5d elected leader 71d28e9ac1bc4e5d at term 2"}
{"level":"info","ts":"2026-03-19T13:35:37.179889Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"71d28e9ac1bc4e5d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.205:2379]}","request-path":"/0/members/71d28e9ac1bc4e5d/attributes","cluster-id":"4a4ae660c7a9a6a7","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-19T13:35:37.179894Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-19T13:35:37.17993Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-19T13:35:37.179914Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-19T13:35:37.180417Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-19T13:35:37.180468Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-19T13:35:37.181096Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-19T13:35:37.181214Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-19T13:35:37.181259Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-19T13:35:37.182503Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-19T13:35:37.183239Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.205:2379"}
{"level":"info","ts":"2026-03-19T13:35:57.961262Z","caller":"traceutil/trace.go:171","msg":"trace[1462899858] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"145.184416ms","start":"2026-03-19T13:35:57.816057Z","end":"2026-03-19T13:35:57.961241Z","steps":["trace[1462899858] 'process raft request'  (duration: 145.087504ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:36:15.036746Z","caller":"traceutil/trace.go:171","msg":"trace[938376422] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"271.744293ms","start":"2026-03-19T13:36:14.764978Z","end":"2026-03-19T13:36:15.036722Z","steps":["trace[938376422] 'process raft request'  (duration: 271.578ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:36:15.864316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.698024ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5646842158213873070 > lease_revoke:<id:4e5d9d064f09bce5>","response":"size:27"}
{"level":"info","ts":"2026-03-19T13:36:15.864479Z","caller":"traceutil/trace.go:171","msg":"trace[1552395622] linearizableReadLoop","detail":"{readStateIndex:572; appliedIndex:571; }","duration":"370.013906ms","start":"2026-03-19T13:36:15.494441Z","end":"2026-03-19T13:36:15.864455Z","steps":["trace[1552395622] 'read index received'  (duration: 159.991176ms)","trace[1552395622] 'applied index is now lower than readState.Index'  (duration: 210.01081ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T13:36:15.864682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.559597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/cert-manager/\" range_end:\"/registry/secrets/cert-manager0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T13:36:15.864723Z","caller":"traceutil/trace.go:171","msg":"trace[1016253114] range","detail":"{range_begin:/registry/secrets/cert-manager/; range_end:/registry/secrets/cert-manager0; response_count:0; response_revision:555; }","duration":"160.674348ms","start":"2026-03-19T13:36:15.704035Z","end":"2026-03-19T13:36:15.86471Z","steps":["trace[1016253114] 'agreement among raft nodes before linearized reading'  (duration: 160.569606ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:36:15.864715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.621439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T13:36:15.864807Z","caller":"traceutil/trace.go:171","msg":"trace[450415538] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:555; }","duration":"139.736032ms","start":"2026-03-19T13:36:15.725047Z","end":"2026-03-19T13:36:15.864783Z","steps":["trace[450415538] 'agreement among raft nodes before linearized reading'  (duration: 139.576959ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:36:15.864933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.453084ms","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-03-19T13:36:15.865169Z","caller":"traceutil/trace.go:171","msg":"trace[439118618] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:555; }","duration":"370.74984ms","start":"2026-03-19T13:36:15.49438Z","end":"2026-03-19T13:36:15.865129Z","steps":["trace[439118618] 'agreement among raft nodes before linearized reading'  (duration: 370.20687ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:36:15.865247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:36:15.494355Z","time spent":"370.877832ms","remote":"127.0.0.1:38420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-19T13:36:35.239801Z","caller":"traceutil/trace.go:171","msg":"trace[781305334] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"245.811597ms","start":"2026-03-19T13:36:34.993941Z","end":"2026-03-19T13:36:35.239752Z","steps":["trace[781305334] 'process raft request'  (duration: 238.475825ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:37:03.621831Z","caller":"traceutil/trace.go:171","msg":"trace[955888974] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"250.184393ms","start":"2026-03-19T13:37:03.371626Z","end":"2026-03-19T13:37:03.62181Z","steps":["trace[955888974] 'process raft request'  (duration: 250.01622ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:27.188626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.849733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-03-19T13:37:27.188802Z","caller":"traceutil/trace.go:171","msg":"trace[1791024025] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1589; }","duration":"259.083027ms","start":"2026-03-19T13:37:26.929695Z","end":"2026-03-19T13:37:27.188778Z","steps":["trace[1791024025] 'range keys from in-memory index tree'  (duration: 258.637608ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:37:27.423673Z","caller":"traceutil/trace.go:171","msg":"trace[953649939] transaction","detail":"{read_only:false; response_revision:1595; number_of_response:1; }","duration":"131.928915ms","start":"2026-03-19T13:37:27.29171Z","end":"2026-03-19T13:37:27.423639Z","steps":["trace[953649939] 'process raft request'  (duration: 131.873904ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:37:27.423706Z","caller":"traceutil/trace.go:171","msg":"trace[203731089] transaction","detail":"{read_only:false; response_revision:1592; number_of_response:1; }","duration":"135.492974ms","start":"2026-03-19T13:37:27.288162Z","end":"2026-03-19T13:37:27.423655Z","steps":["trace[203731089] 'process raft request'  (duration: 135.045116ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:37:27.423976Z","caller":"traceutil/trace.go:171","msg":"trace[1104552254] transaction","detail":"{read_only:false; response_revision:1594; number_of_response:1; }","duration":"134.916813ms","start":"2026-03-19T13:37:27.289047Z","end":"2026-03-19T13:37:27.423964Z","steps":["trace[1104552254] 'process raft request'  (duration: 134.485165ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:37:27.424228Z","caller":"traceutil/trace.go:171","msg":"trace[1003223783] transaction","detail":"{read_only:false; response_revision:1593; number_of_response:1; }","duration":"135.871931ms","start":"2026-03-19T13:37:27.288253Z","end":"2026-03-19T13:37:27.424125Z","steps":["trace[1003223783] 'process raft request'  (duration: 135.173838ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:38:16.790754Z","caller":"traceutil/trace.go:171","msg":"trace[915485697] linearizableReadLoop","detail":"{readStateIndex:1958; appliedIndex:1957; }","duration":"338.598309ms","start":"2026-03-19T13:38:16.452116Z","end":"2026-03-19T13:38:16.790715Z","steps":["trace[915485697] 'read index received'  (duration: 338.375505ms)","trace[915485697] 'applied index is now lower than readState.Index'  (duration: 221.594µs)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:38:16.790822Z","caller":"traceutil/trace.go:171","msg":"trace[156841408] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"345.414644ms","start":"2026-03-19T13:38:16.445355Z","end":"2026-03-19T13:38:16.79077Z","steps":["trace[156841408] 'process raft request'  (duration: 345.18472ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:16.791129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.504585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-03-19T13:38:16.791246Z","caller":"traceutil/trace.go:171","msg":"trace[5274328] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1885; }","duration":"215.667838ms","start":"2026-03-19T13:38:16.575552Z","end":"2026-03-19T13:38:16.791219Z","steps":["trace[5274328] 'agreement among raft nodes before linearized reading'  (duration: 215.437794ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:16.791511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.190011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-03-19T13:38:16.791556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.363212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"}
{"level":"info","ts":"2026-03-19T13:38:16.791642Z","caller":"traceutil/trace.go:171","msg":"trace[227736634] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1885; }","duration":"339.512907ms","start":"2026-03-19T13:38:16.452108Z","end":"2026-03-19T13:38:16.791621Z","steps":["trace[227736634] 'agreement among raft nodes before linearized reading'  (duration: 338.823984ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:38:16.791663Z","caller":"traceutil/trace.go:171","msg":"trace[1181377433] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1885; }","duration":"151.534574ms","start":"2026-03-19T13:38:16.640101Z","end":"2026-03-19T13:38:16.791636Z","steps":["trace[1181377433] 'agreement among raft nodes before linearized reading'  (duration: 151.187908ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:16.791677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:38:16.445335Z","time spent":"345.580517ms","remote":"127.0.0.1:38420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1874 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-03-19T13:38:16.791707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:38:16.452057Z","time spent":"339.633009ms","remote":"127.0.0.1:38420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-03-19T13:39:39.205481Z","caller":"traceutil/trace.go:171","msg":"trace[1979513667] transaction","detail":"{read_only:false; response_revision:2484; number_of_response:1; }","duration":"113.493775ms","start":"2026-03-19T13:39:39.091946Z","end":"2026-03-19T13:39:39.205439Z","steps":["trace[1979513667] 'process raft request'  (duration: 113.25394ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:39:39.376727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.425635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-03-19T13:39:39.376829Z","caller":"traceutil/trace.go:171","msg":"trace[93007081] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2484; }","duration":"115.553557ms","start":"2026-03-19T13:39:39.261239Z","end":"2026-03-19T13:39:39.376792Z","steps":["trace[93007081] 'range keys from in-memory index tree'  (duration: 115.265671ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:39:39.376963Z","caller":"traceutil/trace.go:171","msg":"trace[1069519195] transaction","detail":"{read_only:false; response_revision:2486; number_of_response:1; }","duration":"114.192749ms","start":"2026-03-19T13:39:39.262744Z","end":"2026-03-19T13:39:39.376936Z","steps":["trace[1069519195] 'process raft request'  (duration: 114.091157ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:39:39.376996Z","caller":"traceutil/trace.go:171","msg":"trace[984280392] transaction","detail":"{read_only:false; response_revision:2485; number_of_response:1; }","duration":"115.241071ms","start":"2026-03-19T13:39:39.261675Z","end":"2026-03-19T13:39:39.376917Z","steps":["trace[984280392] 'process raft request'  (duration: 98.949344ms)","trace[984280392] 'compare'  (duration: 15.893429ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T13:39:39.377456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.575679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:553"}
{"level":"info","ts":"2026-03-19T13:39:39.37751Z","caller":"traceutil/trace.go:171","msg":"trace[1072071511] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2486; }","duration":"115.63688ms","start":"2026-03-19T13:39:39.261855Z","end":"2026-03-19T13:39:39.377492Z","steps":["trace[1072071511] 'agreement among raft nodes before linearized reading'  (duration: 115.515907ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:39:39.377534Z","caller":"traceutil/trace.go:171","msg":"trace[1844863974] linearizableReadLoop","detail":"{readStateIndex:2582; appliedIndex:2581; }","duration":"115.057528ms","start":"2026-03-19T13:39:39.261871Z","end":"2026-03-19T13:39:39.376929Z","steps":["trace[1844863974] 'read index received'  (duration: 98.7713ms)","trace[1844863974] 'applied index is now lower than readState.Index'  (duration: 16.284918ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:39:39.585238Z","caller":"traceutil/trace.go:171","msg":"trace[554276929] transaction","detail":"{read_only:false; response_revision:2487; number_of_response:1; }","duration":"203.712913ms","start":"2026-03-19T13:39:39.381505Z","end":"2026-03-19T13:39:39.585218Z","steps":["trace[554276929] 'process raft request'  (duration: 147.310828ms)","trace[554276929] 'compare'  (duration: 56.272873ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:39:39.615081Z","caller":"traceutil/trace.go:171","msg":"trace[1837326059] linearizableReadLoop","detail":"{readStateIndex:2585; appliedIndex:2583; }","duration":"128.058179ms","start":"2026-03-19T13:39:39.486993Z","end":"2026-03-19T13:39:39.615051Z","steps":["trace[1837326059] 'read index received'  (duration: 41.745161ms)","trace[1837326059] 'applied index is now lower than readState.Index'  (duration: 86.311988ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:39:39.615303Z","caller":"traceutil/trace.go:171","msg":"trace[298197332] transaction","detail":"{read_only:false; response_revision:2488; number_of_response:1; }","duration":"233.131155ms","start":"2026-03-19T13:39:39.382085Z","end":"2026-03-19T13:39:39.615216Z","steps":["trace[298197332] 'process raft request'  (duration: 232.821489ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:39:39.615386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.380946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-03-19T13:39:39.615475Z","caller":"traceutil/trace.go:171","msg":"trace[530660484] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2488; }","duration":"128.518819ms","start":"2026-03-19T13:39:39.486934Z","end":"2026-03-19T13:39:39.615452Z","steps":["trace[530660484] 'agreement among raft nodes before linearized reading'  (duration: 128.280453ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:42:05.452705Z","caller":"traceutil/trace.go:171","msg":"trace[1031963980] transaction","detail":"{read_only:false; response_revision:3384; number_of_response:1; }","duration":"119.888015ms","start":"2026-03-19T13:42:05.332788Z","end":"2026-03-19T13:42:05.452676Z","steps":["trace[1031963980] 'process raft request'  (duration: 119.726351ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:42:05.663766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.246743ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5646842158213879715 > lease_revoke:<id:4e5d9d064f09d6c2>","response":"size:27"}
{"level":"info","ts":"2026-03-19T13:43:23.586712Z","caller":"traceutil/trace.go:171","msg":"trace[1289912158] transaction","detail":"{read_only:false; response_revision:4412; number_of_response:1; }","duration":"134.148473ms","start":"2026-03-19T13:43:23.452517Z","end":"2026-03-19T13:43:23.586666Z","steps":["trace[1289912158] 'process raft request'  (duration: 121.050376ms)","trace[1289912158] 'compare'  (duration: 12.801962ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:43:25.934791Z","caller":"traceutil/trace.go:171","msg":"trace[863017951] transaction","detail":"{read_only:false; response_revision:4529; number_of_response:1; }","duration":"128.777822ms","start":"2026-03-19T13:43:25.805948Z","end":"2026-03-19T13:43:25.934726Z","steps":["trace[863017951] 'process raft request'  (duration: 128.556267ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:43:28.239788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.713029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-19T13:43:28.239887Z","caller":"traceutil/trace.go:171","msg":"trace[1737581650] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:4568; }","duration":"122.898673ms","start":"2026-03-19T13:43:28.116967Z","end":"2026-03-19T13:43:28.239866Z","steps":["trace[1737581650] 'count revisions from in-memory index tree'  (duration: 122.625397ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:43:28.240191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.873915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:777465"}
{"level":"info","ts":"2026-03-19T13:43:28.240279Z","caller":"traceutil/trace.go:171","msg":"trace[1081462866] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:4568; }","duration":"130.013278ms","start":"2026-03-19T13:43:28.110245Z","end":"2026-03-19T13:43:28.240258Z","steps":["trace[1081462866] 'range keys from in-memory index tree'  (duration: 129.417656ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:44:12.952618Z","caller":"traceutil/trace.go:171","msg":"trace[1892675107] linearizableReadLoop","detail":"{readStateIndex:5269; appliedIndex:5268; }","duration":"120.853331ms","start":"2026-03-19T13:44:12.831744Z","end":"2026-03-19T13:44:12.952597Z","steps":["trace[1892675107] 'read index received'  (duration: 105.376335ms)","trace[1892675107] 'applied index is now lower than readState.Index'  (duration: 15.476046ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:44:12.952716Z","caller":"traceutil/trace.go:171","msg":"trace[1522185061] transaction","detail":"{read_only:false; response_revision:5076; number_of_response:1; }","duration":"121.670177ms","start":"2026-03-19T13:44:12.831002Z","end":"2026-03-19T13:44:12.952672Z","steps":["trace[1522185061] 'process raft request'  (duration: 106.156041ms)","trace[1522185061] 'compare'  (duration: 15.22193ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T13:44:12.952929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.289459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-dvxz2\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-03-19T13:44:12.953023Z","caller":"traceutil/trace.go:171","msg":"trace[1018390393] range","detail":"{range_begin:/registry/pods/openstack/keepalived-dvxz2; range_end:; response_count:1; response_revision:5076; }","duration":"119.406832ms","start":"2026-03-19T13:44:12.833593Z","end":"2026-03-19T13:44:12.953Z","steps":["trace[1018390393] 'agreement among raft nodes before linearized reading'  (duration: 119.156016ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:44:12.953423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.655018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:85 size:63165"}
{"level":"info","ts":"2026-03-19T13:44:12.953503Z","caller":"traceutil/trace.go:171","msg":"trace[1654047651] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:85; response_revision:5076; }","duration":"121.74845ms","start":"2026-03-19T13:44:12.831741Z","end":"2026-03-19T13:44:12.95349Z","steps":["trace[1654047651] 'agreement among raft nodes before linearized reading'  (duration: 120.971993ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:44:12.95353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.598316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:85 size:63165"}
{"level":"info","ts":"2026-03-19T13:44:12.953583Z","caller":"traceutil/trace.go:171","msg":"trace[1746987607] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:85; response_revision:5076; }","duration":"118.695288ms","start":"2026-03-19T13:44:12.834872Z","end":"2026-03-19T13:44:12.953567Z","steps":["trace[1746987607] 'agreement among raft nodes before linearized reading'  (duration: 118.031084ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:44:18.480019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.274474ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5646842158213885129 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5092 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:476 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-19T13:44:18.480297Z","caller":"traceutil/trace.go:171","msg":"trace[2042299835] linearizableReadLoop","detail":"{readStateIndex:5294; appliedIndex:5293; }","duration":"221.101731ms","start":"2026-03-19T13:44:18.25917Z","end":"2026-03-19T13:44:18.480272Z","steps":["trace[2042299835] 'read index received'  (duration: 89.415778ms)","trace[2042299835] 'applied index is now lower than readState.Index'  (duration: 131.683563ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T13:44:18.480541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.351986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T13:44:18.48051Z","caller":"traceutil/trace.go:171","msg":"trace[1364291592] transaction","detail":"{read_only:false; response_revision:5100; number_of_response:1; }","duration":"247.257007ms","start":"2026-03-19T13:44:18.233203Z","end":"2026-03-19T13:44:18.48046Z","steps":["trace[1364291592] 'process raft request'  (duration: 115.435801ms)","trace[1364291592] 'compare'  (duration: 131.125971ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:44:18.480614Z","caller":"traceutil/trace.go:171","msg":"trace[1691898551] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:5100; }","duration":"221.459988ms","start":"2026-03-19T13:44:18.259135Z","end":"2026-03-19T13:44:18.480595Z","steps":["trace[1691898551] 'agreement among raft nodes before linearized reading'  (duration: 221.342056ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:44:18.480687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.207104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pv-protection-controller\" ","response":"range_response_count:1 size:214"}
{"level":"warn","ts":"2026-03-19T13:44:18.480707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.336429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pod-garbage-collector\" ","response":"range_response_count:1 size:207"}
{"level":"info","ts":"2026-03-19T13:44:18.480777Z","caller":"traceutil/trace.go:171","msg":"trace[2027716918] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pv-protection-controller; range_end:; response_count:1; response_revision:5100; }","duration":"219.339016ms","start":"2026-03-19T13:44:18.261419Z","end":"2026-03-19T13:44:18.480758Z","steps":["trace[2027716918] 'agreement among raft nodes before linearized reading'  (duration: 219.142812ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:44:18.480789Z","caller":"traceutil/trace.go:171","msg":"trace[1551745054] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pod-garbage-collector; range_end:; response_count:1; response_revision:5100; }","duration":"205.483133ms","start":"2026-03-19T13:44:18.275286Z","end":"2026-03-19T13:44:18.480769Z","steps":["trace[1551745054] 'agreement among raft nodes before linearized reading'  (duration: 205.296629ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:44:18.480882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.140928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"}
{"level":"info","ts":"2026-03-19T13:44:18.481013Z","caller":"traceutil/trace.go:171","msg":"trace[1185018266] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5100; }","duration":"145.259891ms","start":"2026-03-19T13:44:18.335696Z","end":"2026-03-19T13:44:18.480956Z","steps":["trace[1185018266] 'agreement among raft nodes before linearized reading'  (duration: 144.880633ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:44:18.699669Z","caller":"traceutil/trace.go:171","msg":"trace[114916045] linearizableReadLoop","detail":"{readStateIndex:5295; appliedIndex:5294; }","duration":"211.836663ms","start":"2026-03-19T13:44:18.487804Z","end":"2026-03-19T13:44:18.699641Z","steps":["trace[114916045] 'read index received'  (duration: 144.876983ms)","trace[114916045] 'applied index is now lower than readState.Index'  (duration: 66.95866ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:44:18.699723Z","caller":"traceutil/trace.go:171","msg":"trace[22585969] transaction","detail":"{read_only:false; response_revision:5101; number_of_response:1; }","duration":"213.67867ms","start":"2026-03-19T13:44:18.486012Z","end":"2026-03-19T13:44:18.699691Z","steps":["trace[22585969] 'process raft request'  (duration: 146.68667ms)","trace[22585969] 'compare'  (duration: 66.822677ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T13:44:18.699866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.209461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pv-protection-controller\" ","response":"range_response_count:1 size:214"}
{"level":"warn","ts":"2026-03-19T13:44:18.699871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.885056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T13:44:18.699907Z","caller":"traceutil/trace.go:171","msg":"trace[1852136130] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pv-protection-controller; range_end:; response_count:1; response_revision:5101; }","duration":"148.300503ms","start":"2026-03-19T13:44:18.551594Z","end":"2026-03-19T13:44:18.699895Z","steps":["trace[1852136130] 'agreement among raft nodes before linearized reading'  (duration: 148.222551ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:44:18.699918Z","caller":"traceutil/trace.go:171","msg":"trace[1924706059] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:5101; }","duration":"173.973708ms","start":"2026-03-19T13:44:18.52593Z","end":"2026-03-19T13:44:18.699904Z","steps":["trace[1924706059] 'agreement among raft nodes before linearized reading'  (duration: 173.880596ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:44:18.700197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.368973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" limit:500 ","response":"range_response_count:4 size:329956"}
{"level":"info","ts":"2026-03-19T13:44:18.700273Z","caller":"traceutil/trace.go:171","msg":"trace[413563221] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:5101; }","duration":"212.474565ms","start":"2026-03-19T13:44:18.48778Z","end":"2026-03-19T13:44:18.700255Z","steps":["trace[413563221] 'agreement among raft nodes before linearized reading'  (duration: 211.973735ms)"],"step_count":1}