{"level":"warn","ts":"2026-05-11T17:53:40.734729Z","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-11T17:53:40.734846Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.63: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.19.213.63:2380","--initial-cluster=instance=https://199.19.213.63:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.63:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.63: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-11T17:53:40.734928Z","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-11T17:53:40.734947Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.63:2380"]} {"level":"info","ts":"2026-05-11T17:53:40.734973Z","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-11T17:53:40.735877Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.63:2379"]} {"level":"info","ts":"2026-05-11T17:53:40.73598Z","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":8,"max-cpu-available":8,"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.19.213.63:2380"],"listen-peer-urls":["https://199.19.213.63:2380"],"advertise-client-urls":["https://199.19.213.63:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.63:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.63: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-11T17:53:40.742706Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.438841ms"} {"level":"info","ts":"2026-05-11T17:53:40.748831Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d75c480e593e7aed","cluster-id":"24fce67309ccbdc"} {"level":"info","ts":"2026-05-11T17:53:40.749028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed switched to configuration voters=()"} {"level":"info","ts":"2026-05-11T17:53:40.749059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed became follower at term 0"} {"level":"info","ts":"2026-05-11T17:53:40.74907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d75c480e593e7aed [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-11T17:53:40.749082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed became follower at term 1"} {"level":"info","ts":"2026-05-11T17:53:40.749119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed switched to configuration voters=(15518357642475895533)"} {"level":"warn","ts":"2026-05-11T17:53:40.755301Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-11T17:53:40.75867Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-11T17:53:40.759858Z","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-11T17:53:40.762261Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d75c480e593e7aed","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-11T17:53:40.762413Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d75c480e593e7aed","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-11T17:53:40.762596Z","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-11T17:53:40.762657Z","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-11T17:53:40.762667Z","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-11T17:53:40.763171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed switched to configuration voters=(15518357642475895533)"} {"level":"info","ts":"2026-05-11T17:53:40.763316Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"24fce67309ccbdc","local-member-id":"d75c480e593e7aed","added-peer-id":"d75c480e593e7aed","added-peer-peer-urls":["https://199.19.213.63:2380"]} {"level":"info","ts":"2026-05-11T17:53:40.768915Z","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-11T17:53:40.769022Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.63:2380"} {"level":"info","ts":"2026-05-11T17:53:40.769036Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.63:2380"} {"level":"info","ts":"2026-05-11T17:53:40.769214Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d75c480e593e7aed","initial-advertise-peer-urls":["https://199.19.213.63:2380"],"listen-peer-urls":["https://199.19.213.63:2380"],"advertise-client-urls":["https://199.19.213.63:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.63:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-11T17:53:40.769251Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-11T17:53:41.049461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed is starting a new election at term 1"} {"level":"info","ts":"2026-05-11T17:53:41.049595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed became pre-candidate at term 1"} {"level":"info","ts":"2026-05-11T17:53:41.049652Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed received MsgPreVoteResp from d75c480e593e7aed at term 1"} {"level":"info","ts":"2026-05-11T17:53:41.049704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed became candidate at term 2"} {"level":"info","ts":"2026-05-11T17:53:41.049741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed received MsgVoteResp from d75c480e593e7aed at term 2"} {"level":"info","ts":"2026-05-11T17:53:41.049774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed became leader at term 2"} {"level":"info","ts":"2026-05-11T17:53:41.049814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d75c480e593e7aed elected leader d75c480e593e7aed at term 2"} {"level":"info","ts":"2026-05-11T17:53:41.050806Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d75c480e593e7aed","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.63:2379]}","request-path":"/0/members/d75c480e593e7aed/attributes","cluster-id":"24fce67309ccbdc","publish-timeout":"7s"} {"level":"info","ts":"2026-05-11T17:53:41.050811Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-11T17:53:41.050984Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-11T17:53:41.05084Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T17:53:41.051114Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-11T17:53:41.051218Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-11T17:53:41.051811Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"24fce67309ccbdc","local-member-id":"d75c480e593e7aed","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T17:53:41.051976Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T17:53:41.052039Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T17:53:41.054501Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-11T17:53:41.054756Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.63:2379"} {"level":"warn","ts":"2026-05-11T17:53:44.262776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.187821ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T17:53:44.263317Z","caller":"traceutil/trace.go:171","msg":"trace[2131157558] transaction","detail":"{read_only:false; response_revision:230; number_of_response:1; }","duration":"368.676237ms","start":"2026-05-11T17:53:43.89462Z","end":"2026-05-11T17:53:44.263296Z","steps":["trace[2131157558] 'process raft request' (duration: 141.228165ms)","trace[2131157558] 'compare' (duration: 226.034729ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T17:53:44.263639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T17:53:43.894603Z","time spent":"368.982822ms","remote":"127.0.0.1:44160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":726,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T17:53:44.472816Z","caller":"traceutil/trace.go:171","msg":"trace[1657058928] transaction","detail":"{read_only:false; response_revision:232; number_of_response:1; }","duration":"108.578957ms","start":"2026-05-11T17:53:44.364207Z","end":"2026-05-11T17:53:44.472786Z","steps":["trace[1657058928] 'process raft request' (duration: 96.991241ms)","trace[1657058928] 'compare' (duration: 11.278701ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T17:54:11.277153Z","caller":"traceutil/trace.go:171","msg":"trace[61162633] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"150.617075ms","start":"2026-05-11T17:54:11.126501Z","end":"2026-05-11T17:54:11.277118Z","steps":["trace[61162633] 'process raft request' (duration: 127.694016ms)","trace[61162633] 'compare' (duration: 22.724667ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T17:54:11.278109Z","caller":"traceutil/trace.go:171","msg":"trace[1050030977] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"139.53236ms","start":"2026-05-11T17:54:11.138563Z","end":"2026-05-11T17:54:11.278095Z","steps":["trace[1050030977] 'process raft request' (duration: 138.496468ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T17:54:12.229493Z","caller":"traceutil/trace.go:171","msg":"trace[241426858] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"193.351557ms","start":"2026-05-11T17:54:12.036066Z","end":"2026-05-11T17:54:12.229417Z","steps":["trace[241426858] 'process raft request' (duration: 192.163503ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T17:54:17.691103Z","caller":"traceutil/trace.go:171","msg":"trace[283256567] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"248.302988ms","start":"2026-05-11T17:54:17.44277Z","end":"2026-05-11T17:54:17.691073Z","steps":["trace[283256567] 'process raft request' (duration: 247.436789ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T17:54:17.691541Z","caller":"traceutil/trace.go:171","msg":"trace[38163937] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"227.061251ms","start":"2026-05-11T17:54:17.464461Z","end":"2026-05-11T17:54:17.691523Z","steps":["trace[38163937] 'read index received' (duration: 225.313892ms)","trace[38163937] 'applied index is now lower than readState.Index' (duration: 1.746129ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T17:54:17.691792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.486199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T17:54:17.691859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.365804ms","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-05-11T17:54:17.691869Z","caller":"traceutil/trace.go:171","msg":"trace[1621862912] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"146.62541ms","start":"2026-05-11T17:54:17.545225Z","end":"2026-05-11T17:54:17.69185Z","steps":["trace[1621862912] 'agreement among raft nodes before linearized reading' (duration: 146.485879ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T17:54:17.691944Z","caller":"traceutil/trace.go:171","msg":"trace[1643406854] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:616; }","duration":"227.501706ms","start":"2026-05-11T17:54:17.464398Z","end":"2026-05-11T17:54:17.691899Z","steps":["trace[1643406854] 'agreement among raft nodes before linearized reading' (duration: 227.243083ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T17:54:18.245483Z","caller":"traceutil/trace.go:171","msg":"trace[1210903348] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"446.894213ms","start":"2026-05-11T17:54:17.798557Z","end":"2026-05-11T17:54:18.245451Z","steps":["trace[1210903348] 'process raft request' (duration: 348.368777ms)","trace[1210903348] 'compare' (duration: 98.390474ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T17:54:18.245853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T17:54:17.798532Z","time spent":"447.026774ms","remote":"127.0.0.1:44002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T17:54:33.83678Z","caller":"traceutil/trace.go:171","msg":"trace[1042393680] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"206.41331ms","start":"2026-05-11T17:54:33.630334Z","end":"2026-05-11T17:54:33.836747Z","steps":["trace[1042393680] 'process raft request' (duration: 153.290773ms)","trace[1042393680] 'compare' (duration: 52.805624ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T17:55:02.928729Z","caller":"traceutil/trace.go:171","msg":"trace[491514681] transaction","detail":"{read_only:false; response_revision:1176; number_of_response:1; }","duration":"162.799562ms","start":"2026-05-11T17:55:02.765895Z","end":"2026-05-11T17:55:02.928695Z","steps":["trace[491514681] 'process raft request' (duration: 162.601056ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T17:55:50.163742Z","caller":"traceutil/trace.go:171","msg":"trace[1581691475] linearizableReadLoop","detail":"{readStateIndex:1925; appliedIndex:1924; }","duration":"213.419172ms","start":"2026-05-11T17:55:49.950281Z","end":"2026-05-11T17:55:50.163701Z","steps":["trace[1581691475] 'read index received' (duration: 198.779163ms)","trace[1581691475] 'applied index is now lower than readState.Index' (duration: 14.637939ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T17:55:50.163968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.639957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-11T17:55:50.164036Z","caller":"traceutil/trace.go:171","msg":"trace[1633412702] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1855; }","duration":"213.79481ms","start":"2026-05-11T17:55:49.950225Z","end":"2026-05-11T17:55:50.16402Z","steps":["trace[1633412702] 'agreement among raft nodes before linearized reading' (duration: 213.582606ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T17:55:50.164338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.206496ms","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-05-11T17:55:50.164415Z","caller":"traceutil/trace.go:171","msg":"trace[1246624559] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1855; }","duration":"149.346049ms","start":"2026-05-11T17:55:50.015046Z","end":"2026-05-11T17:55:50.164392Z","steps":["trace[1246624559] 'agreement among raft nodes before linearized reading' (duration: 148.939069ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T17:55:50.547109Z","caller":"traceutil/trace.go:171","msg":"trace[385502304] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"182.575641ms","start":"2026-05-11T17:55:50.364502Z","end":"2026-05-11T17:55:50.547077Z","steps":["trace[385502304] 'process raft request' (duration: 181.960098ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T17:56:02.893485Z","caller":"traceutil/trace.go:171","msg":"trace[77339250] linearizableReadLoop","detail":"{readStateIndex:2031; appliedIndex:2030; }","duration":"250.373658ms","start":"2026-05-11T17:56:02.643086Z","end":"2026-05-11T17:56:02.89346Z","steps":["trace[77339250] 'read index received' (duration: 250.211795ms)","trace[77339250] 'applied index is now lower than readState.Index' (duration: 160.963µs)"],"step_count":2} {"level":"info","ts":"2026-05-11T17:56:02.8936Z","caller":"traceutil/trace.go:171","msg":"trace[116242339] transaction","detail":"{read_only:false; response_revision:1959; number_of_response:1; }","duration":"251.480479ms","start":"2026-05-11T17:56:02.642079Z","end":"2026-05-11T17:56:02.89356Z","steps":["trace[116242339] 'process raft request' (duration: 251.220774ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T17:56:02.893725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.620614ms","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-05-11T17:56:02.893776Z","caller":"traceutil/trace.go:171","msg":"trace[543822718] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1959; }","duration":"250.713135ms","start":"2026-05-11T17:56:02.643048Z","end":"2026-05-11T17:56:02.893761Z","steps":["trace[543822718] 'agreement among raft nodes before linearized reading' (duration: 250.531862ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T17:56:20.089997Z","caller":"traceutil/trace.go:171","msg":"trace[374397981] linearizableReadLoop","detail":"{readStateIndex:2146; appliedIndex:2145; }","duration":"105.591464ms","start":"2026-05-11T17:56:19.984361Z","end":"2026-05-11T17:56:20.089953Z","steps":["trace[374397981] 'read index received' (duration: 20.272704ms)","trace[374397981] 'applied index is now lower than readState.Index' (duration: 85.3171ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T17:56:20.090215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.818988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T17:56:20.090382Z","caller":"traceutil/trace.go:171","msg":"trace[1727768099] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:2070; }","duration":"105.977061ms","start":"2026-05-11T17:56:19.984312Z","end":"2026-05-11T17:56:20.090289Z","steps":["trace[1727768099] 'agreement among raft nodes before linearized reading' (duration: 105.776287ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T17:56:20.324387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.052351ms","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-11T17:56:20.324526Z","caller":"traceutil/trace.go:171","msg":"trace[14610044] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:2071; }","duration":"128.265254ms","start":"2026-05-11T17:56:20.196232Z","end":"2026-05-11T17:56:20.324498Z","steps":["trace[14610044] 'count revisions from in-memory index tree' (duration: 127.888879ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T17:56:20.446501Z","caller":"traceutil/trace.go:171","msg":"trace[1676580302] transaction","detail":"{read_only:false; response_revision:2072; number_of_response:1; }","duration":"105.695813ms","start":"2026-05-11T17:56:20.340781Z","end":"2026-05-11T17:56:20.446477Z","steps":["trace[1676580302] 'process raft request' (duration: 105.53861ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T17:56:20.722479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.029476ms","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-05-11T17:56:20.722609Z","caller":"traceutil/trace.go:171","msg":"trace[757045111] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2072; }","duration":"190.231409ms","start":"2026-05-11T17:56:20.532355Z","end":"2026-05-11T17:56:20.722586Z","steps":["trace[757045111] 'range keys from in-memory index tree' (duration: 189.6895ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T17:56:20.723244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.453699ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T17:56:20.723454Z","caller":"traceutil/trace.go:171","msg":"trace[1531360094] transaction","detail":"{read_only:false; response_revision:2073; number_of_response:1; }","duration":"186.76862ms","start":"2026-05-11T17:56:20.536572Z","end":"2026-05-11T17:56:20.723341Z","steps":["trace[1531360094] 'process raft request' (duration: 16.887753ms)","trace[1531360094] 'compare' (duration: 169.086193ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T17:56:21.095538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.753708ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T17:56:21.096048Z","caller":"traceutil/trace.go:171","msg":"trace[562179263] transaction","detail":"{read_only:false; response_revision:2075; number_of_response:1; }","duration":"143.598082ms","start":"2026-05-11T17:56:20.952415Z","end":"2026-05-11T17:56:21.096013Z","steps":["trace[562179263] 'compare' (duration: 134.383362ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T17:56:21.399016Z","caller":"traceutil/trace.go:171","msg":"trace[1381785498] transaction","detail":"{read_only:false; response_revision:2077; number_of_response:1; }","duration":"226.014147ms","start":"2026-05-11T17:56:21.172951Z","end":"2026-05-11T17:56:21.398965Z","steps":["trace[1381785498] 'process raft request' (duration: 225.469178ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T17:58:07.443739Z","caller":"traceutil/trace.go:171","msg":"trace[519060945] transaction","detail":"{read_only:false; response_revision:2752; number_of_response:1; }","duration":"124.349259ms","start":"2026-05-11T17:58:07.319344Z","end":"2026-05-11T17:58:07.443694Z","steps":["trace[519060945] 'process raft request' (duration: 124.127396ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T17:58:07.508274Z","caller":"traceutil/trace.go:171","msg":"trace[469948289] transaction","detail":"{read_only:false; response_revision:2753; number_of_response:1; }","duration":"164.854114ms","start":"2026-05-11T17:58:07.343379Z","end":"2026-05-11T17:58:07.508233Z","steps":["trace[469948289] 'process raft request' (duration: 146.362458ms)","trace[469948289] 'compare' (duration: 18.281213ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T18:02:01.074534Z","caller":"traceutil/trace.go:171","msg":"trace[895484756] transaction","detail":"{read_only:false; response_revision:4672; number_of_response:1; }","duration":"150.399421ms","start":"2026-05-11T18:02:00.924096Z","end":"2026-05-11T18:02:01.074496Z","steps":["trace[895484756] 'process raft request' (duration: 62.537185ms)","trace[895484756] 'compare' (duration: 87.485637ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T18:02:01.097293Z","caller":"traceutil/trace.go:171","msg":"trace[1841309623] transaction","detail":"{read_only:false; response_revision:4674; number_of_response:1; }","duration":"172.508864ms","start":"2026-05-11T18:02:00.924753Z","end":"2026-05-11T18:02:01.097262Z","steps":["trace[1841309623] 'process raft request' (duration: 172.428102ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T18:02:01.097542Z","caller":"traceutil/trace.go:171","msg":"trace[470235296] transaction","detail":"{read_only:false; response_revision:4673; number_of_response:1; }","duration":"173.229692ms","start":"2026-05-11T18:02:00.924278Z","end":"2026-05-11T18:02:01.097508Z","steps":["trace[470235296] 'process raft request' (duration: 172.776131ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T18:02:06.382638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.656343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cc749f1b-6875-44b4-957b-1fd9d84784e6\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-05-11T18:02:06.382821Z","caller":"traceutil/trace.go:171","msg":"trace[1934592129] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cc749f1b-6875-44b4-957b-1fd9d84784e6; range_end:; response_count:1; response_revision:4772; }","duration":"108.915309ms","start":"2026-05-11T18:02:06.273876Z","end":"2026-05-11T18:02:06.382791Z","steps":["trace[1934592129] 'range keys from in-memory index tree' (duration: 108.416947ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T18:02:19.037081Z","caller":"traceutil/trace.go:171","msg":"trace[1181942012] transaction","detail":"{read_only:false; response_revision:4962; number_of_response:1; }","duration":"111.481769ms","start":"2026-05-11T18:02:18.925564Z","end":"2026-05-11T18:02:19.037046Z","steps":["trace[1181942012] 'process raft request' (duration: 111.192982ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T18:02:19.740201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.756993ms","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-11T18:02:19.740958Z","caller":"traceutil/trace.go:171","msg":"trace[1861350205] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4963; }","duration":"108.559413ms","start":"2026-05-11T18:02:19.632363Z","end":"2026-05-11T18:02:19.740923Z","steps":["trace[1861350205] 'range keys from in-memory index tree' (duration: 107.510147ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T18:03:41.149177Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2929} {"level":"info","ts":"2026-05-11T18:03:41.330187Z","caller":"traceutil/trace.go:171","msg":"trace[864024990] transaction","detail":"{read_only:false; response_revision:5606; number_of_response:1; }","duration":"114.188854ms","start":"2026-05-11T18:03:41.215954Z","end":"2026-05-11T18:03:41.330143Z","steps":["trace[864024990] 'process raft request' (duration: 20.670027ms)","trace[864024990] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/jobs/openstack/keystone-db-sync; req_size:8399; } (duration: 93.140079ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T18:03:41.379806Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2929,"took":"228.478071ms","hash":2900394683,"current-db-size-bytes":53125120,"current-db-size":"53 MB","current-db-size-in-use-bytes":29200384,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-11T18:03:41.379871Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2900394683,"revision":2929,"compact-revision":-1} {"level":"info","ts":"2026-05-11T18:08:41.156064Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5604} {"level":"info","ts":"2026-05-11T18:08:41.243055Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5604,"took":"85.063724ms","hash":811806530,"current-db-size-bytes":53125120,"current-db-size":"53 MB","current-db-size-in-use-bytes":18202624,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-11T18:08:41.243128Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":811806530,"revision":5604,"compact-revision":2929}