{"level":"warn","ts":"2026-05-31T14:05:13.467067Z","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-31T14:05:13.46714Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.22: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.22:2380","--initial-cluster=instance=https://199.204.45.22:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.22:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.22: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-31T14:05:13.467194Z","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-31T14:05:13.467206Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-05-31T14:05:13.467222Z","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-31T14:05:13.467836Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"]} {"level":"info","ts":"2026-05-31T14:05:13.467906Z","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.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.22: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-31T14:05:13.471756Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.664082ms"} {"level":"info","ts":"2026-05-31T14:05:13.477269Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fed19d9291630e09","cluster-id":"6ebf1e01320cc017"} {"level":"info","ts":"2026-05-31T14:05:13.477349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=()"} {"level":"info","ts":"2026-05-31T14:05:13.477367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 0"} {"level":"info","ts":"2026-05-31T14:05:13.47738Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fed19d9291630e09 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-31T14:05:13.477389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 1"} {"level":"info","ts":"2026-05-31T14:05:13.477429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"warn","ts":"2026-05-31T14:05:13.485445Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-31T14:05:13.487347Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-31T14:05:13.488675Z","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-31T14:05:13.490545Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fed19d9291630e09","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-31T14:05:13.490928Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fed19d9291630e09","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-31T14:05:13.491043Z","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-31T14:05:13.491068Z","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-31T14:05:13.491074Z","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-31T14:05:13.49273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"info","ts":"2026-05-31T14:05:13.493011Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","added-peer-id":"fed19d9291630e09","added-peer-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-05-31T14:05:13.494256Z","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-31T14:05:13.49445Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-05-31T14:05:13.49453Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-05-31T14:05:13.494947Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fed19d9291630e09","initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-31T14:05:13.494969Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-31T14:05:14.478409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 is starting a new election at term 1"} {"level":"info","ts":"2026-05-31T14:05:14.478479Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-31T14:05:14.478516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgPreVoteResp from fed19d9291630e09 at term 1"} {"level":"info","ts":"2026-05-31T14:05:14.478534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became candidate at term 2"} {"level":"info","ts":"2026-05-31T14:05:14.478545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgVoteResp from fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-05-31T14:05:14.478561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became leader at term 2"} {"level":"info","ts":"2026-05-31T14:05:14.478575Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fed19d9291630e09 elected leader fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-05-31T14:05:14.479356Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-31T14:05:14.480258Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-31T14:05:14.480778Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-31T14:05:14.480796Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","cluster-version":"3.5"} {"level":"info","ts":"2026-05-31T14:05:14.480952Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-31T14:05:14.48099Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-31T14:05:14.480214Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fed19d9291630e09","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.22:2379]}","request-path":"/0/members/fed19d9291630e09/attributes","cluster-id":"6ebf1e01320cc017","publish-timeout":"7s"} {"level":"info","ts":"2026-05-31T14:05:14.482457Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-31T14:05:14.482566Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-31T14:05:14.484238Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.22:2379"} {"level":"info","ts":"2026-05-31T14:05:14.484866Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-31T14:05:51.224177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.085041ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-31T14:05:51.224546Z","caller":"traceutil/trace.go:171","msg":"trace[1681729660] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"159.589112ms","start":"2026-05-31T14:05:51.064933Z","end":"2026-05-31T14:05:51.224523Z","steps":["trace[1681729660] 'process raft request' (duration: 159.446331ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T14:05:51.225095Z","caller":"traceutil/trace.go:171","msg":"trace[1703637213] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"186.992233ms","start":"2026-05-31T14:05:51.038086Z","end":"2026-05-31T14:05:51.225078Z","steps":["trace[1703637213] 'process raft request' (duration: 27.168374ms)","trace[1703637213] 'compare' (duration: 157.861454ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T14:05:57.425279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.89672ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-31T14:05:57.425434Z","caller":"traceutil/trace.go:171","msg":"trace[1929266345] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"424.448883ms","start":"2026-05-31T14:05:57.000952Z","end":"2026-05-31T14:05:57.425401Z","steps":["trace[1929266345] 'process raft request' (duration: 254.174534ms)","trace[1929266345] 'compare' (duration: 169.775771ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T14:05:57.42553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T14:05:57.000925Z","time spent":"424.564241ms","remote":"127.0.0.1:49866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-31T14:06:44.833854Z","caller":"traceutil/trace.go:171","msg":"trace[1915361032] linearizableReadLoop","detail":"{readStateIndex:1196; appliedIndex:1195; }","duration":"151.390838ms","start":"2026-05-31T14:06:44.682434Z","end":"2026-05-31T14:06:44.833825Z","steps":["trace[1915361032] 'read index received' (duration: 151.124922ms)","trace[1915361032] 'applied index is now lower than readState.Index' (duration: 264.706µs)"],"step_count":2} {"level":"info","ts":"2026-05-31T14:06:44.833997Z","caller":"traceutil/trace.go:171","msg":"trace[1929640435] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"171.547125ms","start":"2026-05-31T14:06:44.662439Z","end":"2026-05-31T14:06:44.833986Z","steps":["trace[1929640435] 'process raft request' (duration: 171.196754ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T14:06:44.834736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.28399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-31T14:06:44.834835Z","caller":"traceutil/trace.go:171","msg":"trace[596252970] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1162; }","duration":"152.432503ms","start":"2026-05-31T14:06:44.682382Z","end":"2026-05-31T14:06:44.834814Z","steps":["trace[596252970] 'agreement among raft nodes before linearized reading' (duration: 151.987926ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T14:07:31.26541Z","caller":"traceutil/trace.go:171","msg":"trace[1789492936] linearizableReadLoop","detail":"{readStateIndex:1911; appliedIndex:1910; }","duration":"160.423375ms","start":"2026-05-31T14:07:31.10496Z","end":"2026-05-31T14:07:31.265383Z","steps":["trace[1789492936] 'read index received' (duration: 121.168183ms)","trace[1789492936] 'applied index is now lower than readState.Index' (duration: 39.254292ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T14:07:31.265455Z","caller":"traceutil/trace.go:171","msg":"trace[644578709] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"264.955158ms","start":"2026-05-31T14:07:31.00047Z","end":"2026-05-31T14:07:31.265425Z","steps":["trace[644578709] 'process raft request' (duration: 225.700526ms)","trace[644578709] 'compare' (duration: 39.085511ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T14:07:31.265695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.718489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-31T14:07:31.265764Z","caller":"traceutil/trace.go:171","msg":"trace[924829165] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1838; }","duration":"160.84197ms","start":"2026-05-31T14:07:31.104908Z","end":"2026-05-31T14:07:31.26575Z","steps":["trace[924829165] 'agreement among raft nodes before linearized reading' (duration: 160.631488ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T14:07:31.265785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.729707ms","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-05-31T14:07:31.265911Z","caller":"traceutil/trace.go:171","msg":"trace[596021917] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1838; }","duration":"158.896789ms","start":"2026-05-31T14:07:31.106988Z","end":"2026-05-31T14:07:31.265885Z","steps":["trace[596021917] 'agreement among raft nodes before linearized reading' (duration: 158.608075ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T14:07:31.636975Z","caller":"traceutil/trace.go:171","msg":"trace[1070878117] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"104.514974ms","start":"2026-05-31T14:07:31.532439Z","end":"2026-05-31T14:07:31.636954Z","steps":["trace[1070878117] 'process raft request' (duration: 104.369522ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T14:08:10.837172Z","caller":"traceutil/trace.go:171","msg":"trace[908844912] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"186.448698ms","start":"2026-05-31T14:08:10.6507Z","end":"2026-05-31T14:08:10.837148Z","steps":["trace[908844912] 'process raft request' (duration: 186.308823ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T14:08:10.837345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.798665ms","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-31T14:08:10.837382Z","caller":"traceutil/trace.go:171","msg":"trace[89958513] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2102; }","duration":"185.882968ms","start":"2026-05-31T14:08:10.651489Z","end":"2026-05-31T14:08:10.837372Z","steps":["trace[89958513] 'agreement among raft nodes before linearized reading' (duration: 185.766753ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T14:08:10.837212Z","caller":"traceutil/trace.go:171","msg":"trace[33820557] linearizableReadLoop","detail":"{readStateIndex:2184; appliedIndex:2184; }","duration":"185.621798ms","start":"2026-05-31T14:08:10.65154Z","end":"2026-05-31T14:08:10.837162Z","steps":["trace[33820557] 'read index received' (duration: 185.596327ms)","trace[33820557] 'applied index is now lower than readState.Index' (duration: 23.101µs)"],"step_count":2} {"level":"info","ts":"2026-05-31T14:08:10.974117Z","caller":"traceutil/trace.go:171","msg":"trace[625063610] linearizableReadLoop","detail":"{readStateIndex:2185; appliedIndex:2184; }","duration":"135.898113ms","start":"2026-05-31T14:08:10.838188Z","end":"2026-05-31T14:08:10.974086Z","steps":["trace[625063610] 'read index received' (duration: 113.600836ms)","trace[625063610] 'applied index is now lower than readState.Index' (duration: 22.296117ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T14:08:10.974153Z","caller":"traceutil/trace.go:171","msg":"trace[1361526103] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"318.584043ms","start":"2026-05-31T14:08:10.655531Z","end":"2026-05-31T14:08:10.974115Z","steps":["trace[1361526103] 'process raft request' (duration: 296.251474ms)","trace[1361526103] 'compare' (duration: 22.190604ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T14:08:10.974391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.002786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-31T14:08:10.974433Z","caller":"traceutil/trace.go:171","msg":"trace[129885891] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2103; }","duration":"306.084659ms","start":"2026-05-31T14:08:10.668337Z","end":"2026-05-31T14:08:10.974422Z","steps":["trace[129885891] 'agreement among raft nodes before linearized reading' (duration: 305.879861ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T14:08:10.974466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T14:08:10.668324Z","time spent":"306.134531ms","remote":"127.0.0.1:49596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-31T14:08:10.974495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T14:08:10.655511Z","time spent":"318.901315ms","remote":"127.0.0.1:49596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-31T14:08:10.974341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.171355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-31T14:08:10.974851Z","caller":"traceutil/trace.go:171","msg":"trace[467767914] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2103; }","duration":"305.755536ms","start":"2026-05-31T14:08:10.669072Z","end":"2026-05-31T14:08:10.974827Z","steps":["trace[467767914] 'agreement among raft nodes before linearized reading' (duration: 305.058011ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T14:08:10.974937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T14:08:10.669052Z","time spent":"305.85747ms","remote":"127.0.0.1:49596","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-05-31T14:08:11.213382Z","caller":"traceutil/trace.go:171","msg":"trace[1766559363] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"147.146942ms","start":"2026-05-31T14:08:11.066199Z","end":"2026-05-31T14:08:11.213346Z","steps":["trace[1766559363] 'process raft request' (duration: 54.697196ms)","trace[1766559363] 'compare' (duration: 92.255759ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T14:09:35.473491Z","caller":"traceutil/trace.go:171","msg":"trace[14160866] transaction","detail":"{read_only:false; response_revision:2671; number_of_response:1; }","duration":"119.943851ms","start":"2026-05-31T14:09:35.353532Z","end":"2026-05-31T14:09:35.473476Z","steps":["trace[14160866] 'process raft request' (duration: 119.662594ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T14:09:35.65398Z","caller":"traceutil/trace.go:171","msg":"trace[261057568] transaction","detail":"{read_only:false; response_revision:2672; number_of_response:1; }","duration":"177.524977ms","start":"2026-05-31T14:09:35.476428Z","end":"2026-05-31T14:09:35.653953Z","steps":["trace[261057568] 'process raft request' (duration: 122.146002ms)","trace[261057568] 'compare' (duration: 55.229086ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T14:09:35.654145Z","caller":"traceutil/trace.go:171","msg":"trace[697451716] transaction","detail":"{read_only:false; response_revision:2673; number_of_response:1; }","duration":"177.696287ms","start":"2026-05-31T14:09:35.476439Z","end":"2026-05-31T14:09:35.654135Z","steps":["trace[697451716] 'process raft request' (duration: 177.472433ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T14:13:12.797499Z","caller":"traceutil/trace.go:171","msg":"trace[626327910] transaction","detail":"{read_only:false; response_revision:4538; number_of_response:1; }","duration":"305.552379ms","start":"2026-05-31T14:13:12.491915Z","end":"2026-05-31T14:13:12.797467Z","steps":["trace[626327910] 'process raft request' (duration: 304.723588ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T14:13:12.797685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T14:13:12.491896Z","time spent":"305.690762ms","remote":"127.0.0.1:49512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11832,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-31T14:13:12.835948Z","caller":"traceutil/trace.go:171","msg":"trace[2017820012] linearizableReadLoop","detail":"{readStateIndex:4713; appliedIndex:4711; }","duration":"233.141269ms","start":"2026-05-31T14:13:12.602702Z","end":"2026-05-31T14:13:12.835843Z","steps":["trace[2017820012] 'read index received' (duration: 193.96367ms)","trace[2017820012] 'applied index is now lower than readState.Index' (duration: 39.175289ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T14:13:12.836172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.345324ms","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-05-31T14:13:12.836248Z","caller":"traceutil/trace.go:171","msg":"trace[584936681] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4538; }","duration":"233.56997ms","start":"2026-05-31T14:13:12.602663Z","end":"2026-05-31T14:13:12.836233Z","steps":["trace[584936681] 'agreement among raft nodes before linearized reading' (duration: 233.20842ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T14:13:12.843757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.59142ms","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-05-31T14:13:12.843841Z","caller":"traceutil/trace.go:171","msg":"trace[954481931] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4540; }","duration":"172.724533ms","start":"2026-05-31T14:13:12.671099Z","end":"2026-05-31T14:13:12.843823Z","steps":["trace[954481931] 'agreement among raft nodes before linearized reading' (duration: 172.485487ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T14:13:12.843987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.639627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-31T14:13:12.844003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.108777ms","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-31T14:13:12.84404Z","caller":"traceutil/trace.go:171","msg":"trace[165504380] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:0; response_revision:4540; }","duration":"157.715999ms","start":"2026-05-31T14:13:12.68631Z","end":"2026-05-31T14:13:12.844026Z","steps":["trace[165504380] 'agreement among raft nodes before linearized reading' (duration: 157.638937ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T14:13:12.844048Z","caller":"traceutil/trace.go:171","msg":"trace[831019284] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4540; }","duration":"156.18608ms","start":"2026-05-31T14:13:12.68785Z","end":"2026-05-31T14:13:12.844036Z","steps":["trace[831019284] 'agreement among raft nodes before linearized reading' (duration: 156.044396ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T14:13:24.79958Z","caller":"traceutil/trace.go:171","msg":"trace[632707369] linearizableReadLoop","detail":"{readStateIndex:4947; appliedIndex:4946; }","duration":"136.887778ms","start":"2026-05-31T14:13:24.662662Z","end":"2026-05-31T14:13:24.799549Z","steps":["trace[632707369] 'read index received' (duration: 136.559319ms)","trace[632707369] 'applied index is now lower than readState.Index' (duration: 327.359µs)"],"step_count":2} {"level":"info","ts":"2026-05-31T14:13:24.799655Z","caller":"traceutil/trace.go:171","msg":"trace[1316885201] transaction","detail":"{read_only:false; response_revision:4766; number_of_response:1; }","duration":"190.461962ms","start":"2026-05-31T14:13:24.609168Z","end":"2026-05-31T14:13:24.79963Z","steps":["trace[1316885201] 'process raft request' (duration: 190.180174ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T14:13:24.799805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.095114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-31T14:13:24.799871Z","caller":"traceutil/trace.go:171","msg":"trace[2121674218] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:4766; }","duration":"137.231158ms","start":"2026-05-31T14:13:24.662627Z","end":"2026-05-31T14:13:24.799858Z","steps":["trace[2121674218] 'agreement among raft nodes before linearized reading' (duration: 137.083974ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T14:13:24.7999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.671378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-05-31T14:13:24.799955Z","caller":"traceutil/trace.go:171","msg":"trace[1555965357] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4766; }","duration":"120.74126ms","start":"2026-05-31T14:13:24.679195Z","end":"2026-05-31T14:13:24.799936Z","steps":["trace[1555965357] 'agreement among raft nodes before linearized reading' (duration: 120.553214ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T14:15:14.503455Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2876} {"level":"info","ts":"2026-05-31T14:15:14.599089Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2876,"took":"94.191186ms","hash":503847195,"current-db-size-bytes":54575104,"current-db-size":"55 MB","current-db-size-in-use-bytes":29573120,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-31T14:15:14.59917Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":503847195,"revision":2876,"compact-revision":-1} {"level":"info","ts":"2026-05-31T14:16:59.403205Z","caller":"traceutil/trace.go:171","msg":"trace[751921815] transaction","detail":"{read_only:false; response_revision:6331; number_of_response:1; }","duration":"136.46112ms","start":"2026-05-31T14:16:59.266692Z","end":"2026-05-31T14:16:59.403153Z","steps":["trace[751921815] 'process raft request' (duration: 136.172485ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T14:17:00.028422Z","caller":"traceutil/trace.go:171","msg":"trace[738252287] transaction","detail":"{read_only:false; response_revision:6333; number_of_response:1; }","duration":"102.860925ms","start":"2026-05-31T14:16:59.925535Z","end":"2026-05-31T14:17:00.028396Z","steps":["trace[738252287] 'process raft request' (duration: 101.104154ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T14:20:14.50845Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5595} {"level":"info","ts":"2026-05-31T14:20:14.606529Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5595,"took":"97.069743ms","hash":1649240027,"current-db-size-bytes":54575104,"current-db-size":"55 MB","current-db-size-in-use-bytes":18022400,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-31T14:20:14.606592Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1649240027,"revision":5595,"compact-revision":2876}