{"level":"warn","ts":"2026-04-07T12:54:42.466213Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-07T12:54:42.466315Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.4: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.4:2380","--initial-cluster=instance=https://199.204.45.4:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.4:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.4: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-04-07T12:54:42.466394Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-07T12:54:42.466409Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-04-07T12:54:42.466429Z","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-04-07T12:54:42.4673Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"]} {"level":"info","ts":"2026-04-07T12:54:42.467389Z","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.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.4: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-04-07T12:54:42.471291Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.682078ms"} {"level":"info","ts":"2026-04-07T12:54:42.48235Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"66f7b57d56ad567d","cluster-id":"ec267dcaac715770"} {"level":"info","ts":"2026-04-07T12:54:42.4825Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T12:54:42.482522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 0"} {"level":"info","ts":"2026-04-07T12:54:42.48253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 66f7b57d56ad567d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T12:54:42.482538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 1"} {"level":"info","ts":"2026-04-07T12:54:42.482573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"warn","ts":"2026-04-07T12:54:42.486781Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T12:54:42.488094Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T12:54:42.489465Z","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-04-07T12:54:42.491548Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"66f7b57d56ad567d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T12:54:42.491732Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"66f7b57d56ad567d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T12:54:42.492001Z","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-04-07T12:54:42.492111Z","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-04-07T12:54:42.49213Z","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-04-07T12:54:42.49444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"info","ts":"2026-04-07T12:54:42.494655Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","added-peer-id":"66f7b57d56ad567d","added-peer-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-04-07T12:54:42.496258Z","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-04-07T12:54:42.496359Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-04-07T12:54:42.496428Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-04-07T12:54:42.496618Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"66f7b57d56ad567d","initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T12:54:42.496673Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T12:54:42.58318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T12:54:42.583242Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T12:54:42.58326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgPreVoteResp from 66f7b57d56ad567d at term 1"} {"level":"info","ts":"2026-04-07T12:54:42.583275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became candidate at term 2"} {"level":"info","ts":"2026-04-07T12:54:42.583283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgVoteResp from 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-04-07T12:54:42.583294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became leader at term 2"} {"level":"info","ts":"2026-04-07T12:54:42.583303Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 66f7b57d56ad567d elected leader 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-04-07T12:54:42.585683Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T12:54:42.586766Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"66f7b57d56ad567d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.4:2379]}","request-path":"/0/members/66f7b57d56ad567d/attributes","cluster-id":"ec267dcaac715770","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T12:54:42.586797Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T12:54:42.586763Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T12:54:42.587052Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T12:54:42.587093Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T12:54:42.587219Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T12:54:42.587324Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T12:54:42.587357Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T12:54:42.590304Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.4:2379"} {"level":"info","ts":"2026-04-07T12:54:42.590467Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-07T12:55:01.213886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.305437ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-07T12:55:06.628632Z","caller":"traceutil/trace.go:171","msg":"trace[1924615145] linearizableReadLoop","detail":"{readStateIndex:438; appliedIndex:437; }","duration":"192.292961ms","start":"2026-04-07T12:55:06.436313Z","end":"2026-04-07T12:55:06.628606Z","steps":["trace[1924615145] 'read index received' (duration: 192.187729ms)","trace[1924615145] 'applied index is now lower than readState.Index' (duration: 104.082µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:55:06.628712Z","caller":"traceutil/trace.go:171","msg":"trace[160699987] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"245.600542ms","start":"2026-04-07T12:55:06.383064Z","end":"2026-04-07T12:55:06.628665Z","steps":["trace[160699987] 'process raft request' (duration: 245.423897ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:55:06.628868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.917197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-07T12:55:06.628953Z","caller":"traceutil/trace.go:171","msg":"trace[396426668] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:420; }","duration":"159.039459ms","start":"2026-04-07T12:55:06.469895Z","end":"2026-04-07T12:55:06.628934Z","steps":["trace[396426668] 'agreement among raft nodes before linearized reading' (duration: 158.884125ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:55:06.628885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.542857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T12:55:06.629072Z","caller":"traceutil/trace.go:171","msg":"trace[1860085260] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:420; }","duration":"192.787693ms","start":"2026-04-07T12:55:06.436268Z","end":"2026-04-07T12:55:06.629056Z","steps":["trace[1860085260] 'agreement among raft nodes before linearized reading' (duration: 192.481756ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:55:11.598415Z","caller":"traceutil/trace.go:171","msg":"trace[1565291301] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"103.521326ms","start":"2026-04-07T12:55:11.49487Z","end":"2026-04-07T12:55:11.598391Z","steps":["trace[1565291301] 'process raft request' (duration: 97.79418ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:55:18.403027Z","caller":"traceutil/trace.go:171","msg":"trace[1359986949] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"491.653374ms","start":"2026-04-07T12:55:17.911343Z","end":"2026-04-07T12:55:18.402997Z","steps":["trace[1359986949] 'process raft request' (duration: 406.532946ms)","trace[1359986949] 'compare' (duration: 84.738459ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T12:55:18.403752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T12:55:17.911324Z","time spent":"491.817957ms","remote":"127.0.0.1:48148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T12:56:24.305127Z","caller":"traceutil/trace.go:171","msg":"trace[674714153] transaction","detail":"{read_only:false; response_revision:1391; number_of_response:1; }","duration":"132.716994ms","start":"2026-04-07T12:56:24.172369Z","end":"2026-04-07T12:56:24.305086Z","steps":["trace[674714153] 'process raft request' (duration: 109.223998ms)","trace[674714153] 'compare' (duration: 23.276051ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:56:47.166819Z","caller":"traceutil/trace.go:171","msg":"trace[1486930912] transaction","detail":"{read_only:false; response_revision:1800; number_of_response:1; }","duration":"176.218396ms","start":"2026-04-07T12:56:46.990551Z","end":"2026-04-07T12:56:47.166769Z","steps":["trace[1486930912] 'process raft request' (duration: 175.982351ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:56:47.543577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.252878ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T12:56:47.54375Z","caller":"traceutil/trace.go:171","msg":"trace[1213669398] linearizableReadLoop","detail":"{readStateIndex:1871; appliedIndex:1869; }","duration":"254.028709ms","start":"2026-04-07T12:56:47.289708Z","end":"2026-04-07T12:56:47.543736Z","steps":["trace[1213669398] 'read index received' (duration: 35.431µs)","trace[1213669398] 'applied index is now lower than readState.Index' (duration: 253.992208ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:56:47.543789Z","caller":"traceutil/trace.go:171","msg":"trace[1884066989] transaction","detail":"{read_only:false; response_revision:1803; number_of_response:1; }","duration":"371.69006ms","start":"2026-04-07T12:56:47.172072Z","end":"2026-04-07T12:56:47.543762Z","steps":["trace[1884066989] 'process raft request' (duration: 371.587418ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:56:47.543799Z","caller":"traceutil/trace.go:171","msg":"trace[394904670] transaction","detail":"{read_only:false; response_revision:1802; number_of_response:1; }","duration":"371.744321ms","start":"2026-04-07T12:56:47.172014Z","end":"2026-04-07T12:56:47.543759Z","steps":["trace[394904670] 'process raft request' (duration: 53.219547ms)","trace[394904670] 'compare' (duration: 318.129455ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T12:56:47.543902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.190632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-078d5a21-5d40-4fa5-b695-e04021abd261\" ","response":"range_response_count:1 size:3625"} {"level":"info","ts":"2026-04-07T12:56:47.543929Z","caller":"traceutil/trace.go:171","msg":"trace[16560821] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-078d5a21-5d40-4fa5-b695-e04021abd261; range_end:; response_count:1; response_revision:1803; }","duration":"254.248314ms","start":"2026-04-07T12:56:47.289674Z","end":"2026-04-07T12:56:47.543923Z","steps":["trace[16560821] 'agreement among raft nodes before linearized reading' (duration: 254.102611ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:56:47.54393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T12:56:47.171895Z","time spent":"371.967637ms","remote":"127.0.0.1:48324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T12:56:47.544002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T12:56:47.172002Z","time spent":"371.881235ms","remote":"127.0.0.1:48324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T12:57:00.357795Z","caller":"traceutil/trace.go:171","msg":"trace[1783960311] linearizableReadLoop","detail":"{readStateIndex:1980; appliedIndex:1979; }","duration":"104.966679ms","start":"2026-04-07T12:57:00.252809Z","end":"2026-04-07T12:57:00.357776Z","steps":["trace[1783960311] 'read index received' (duration: 92.027652ms)","trace[1783960311] 'applied index is now lower than readState.Index' (duration: 12.938097ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:57:00.357896Z","caller":"traceutil/trace.go:171","msg":"trace[554903713] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"138.314034ms","start":"2026-04-07T12:57:00.219572Z","end":"2026-04-07T12:57:00.357886Z","steps":["trace[554903713] 'process raft request' (duration: 125.234463ms)","trace[554903713] 'compare' (duration: 12.712692ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T12:57:00.358256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.425901ms","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-04-07T12:57:00.358346Z","caller":"traceutil/trace.go:171","msg":"trace[1975129448] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1908; }","duration":"105.562284ms","start":"2026-04-07T12:57:00.252761Z","end":"2026-04-07T12:57:00.358323Z","steps":["trace[1975129448] 'agreement among raft nodes before linearized reading' (duration: 105.302588ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:57:03.822976Z","caller":"traceutil/trace.go:171","msg":"trace[261328914] transaction","detail":"{read_only:false; response_revision:1936; number_of_response:1; }","duration":"167.872817ms","start":"2026-04-07T12:57:03.655082Z","end":"2026-04-07T12:57:03.822955Z","steps":["trace[261328914] 'process raft request' (duration: 167.722684ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:57:03.835245Z","caller":"traceutil/trace.go:171","msg":"trace[1951382440] transaction","detail":"{read_only:false; response_revision:1937; number_of_response:1; }","duration":"180.054708ms","start":"2026-04-07T12:57:03.655168Z","end":"2026-04-07T12:57:03.835223Z","steps":["trace[1951382440] 'process raft request' (duration: 179.933985ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:57:04.494104Z","caller":"traceutil/trace.go:171","msg":"trace[1085909384] linearizableReadLoop","detail":"{readStateIndex:2012; appliedIndex:2011; }","duration":"110.146862ms","start":"2026-04-07T12:57:04.383933Z","end":"2026-04-07T12:57:04.49408Z","steps":["trace[1085909384] 'read index received' (duration: 109.905577ms)","trace[1085909384] 'applied index is now lower than readState.Index' (duration: 240.085µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:57:04.494185Z","caller":"traceutil/trace.go:171","msg":"trace[368281262] transaction","detail":"{read_only:false; response_revision:1939; number_of_response:1; }","duration":"123.683545ms","start":"2026-04-07T12:57:04.37046Z","end":"2026-04-07T12:57:04.494144Z","steps":["trace[368281262] 'process raft request' (duration: 123.452499ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:57:04.494356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.415209ms","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-04-07T12:57:04.49445Z","caller":"traceutil/trace.go:171","msg":"trace[419062930] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1939; }","duration":"110.587713ms","start":"2026-04-07T12:57:04.383846Z","end":"2026-04-07T12:57:04.494434Z","steps":["trace[419062930] 'agreement among raft nodes before linearized reading' (duration: 110.367637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:57:04.495306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.131306ms","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-04-07T12:57:04.495356Z","caller":"traceutil/trace.go:171","msg":"trace[1963750007] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1940; }","duration":"111.212858ms","start":"2026-04-07T12:57:04.384125Z","end":"2026-04-07T12:57:04.495338Z","steps":["trace[1963750007] 'agreement among raft nodes before linearized reading' (duration: 111.088225ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:57:42.264653Z","caller":"traceutil/trace.go:171","msg":"trace[1967393969] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"239.475903ms","start":"2026-04-07T12:57:42.025148Z","end":"2026-04-07T12:57:42.264624Z","steps":["trace[1967393969] 'process raft request' (duration: 148.454864ms)","trace[1967393969] 'compare' (duration: 90.904216ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:57:42.763993Z","caller":"traceutil/trace.go:171","msg":"trace[2182523] transaction","detail":"{read_only:false; response_revision:2149; number_of_response:1; }","duration":"127.644528ms","start":"2026-04-07T12:57:42.636323Z","end":"2026-04-07T12:57:42.763967Z","steps":["trace[2182523] 'process raft request' (duration: 127.485114ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:57:42.896243Z","caller":"traceutil/trace.go:171","msg":"trace[1736349111] linearizableReadLoop","detail":"{readStateIndex:2231; appliedIndex:2229; }","duration":"208.786561ms","start":"2026-04-07T12:57:42.687437Z","end":"2026-04-07T12:57:42.896224Z","steps":["trace[1736349111] 'read index received' (duration: 76.430337ms)","trace[1736349111] 'applied index is now lower than readState.Index' (duration: 132.355494ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:57:42.89629Z","caller":"traceutil/trace.go:171","msg":"trace[213827797] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"252.323132ms","start":"2026-04-07T12:57:42.643931Z","end":"2026-04-07T12:57:42.896254Z","steps":["trace[213827797] 'process raft request' (duration: 169.677592ms)","trace[213827797] 'compare' (duration: 82.460065ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:57:42.896395Z","caller":"traceutil/trace.go:171","msg":"trace[1233251937] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"114.986033ms","start":"2026-04-07T12:57:42.781378Z","end":"2026-04-07T12:57:42.896364Z","steps":["trace[1233251937] 'process raft request' (duration: 114.816879ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:57:42.896489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.018926ms","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-04-07T12:57:42.896522Z","caller":"traceutil/trace.go:171","msg":"trace[332704487] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2151; }","duration":"209.124729ms","start":"2026-04-07T12:57:42.687388Z","end":"2026-04-07T12:57:42.896513Z","steps":["trace[332704487] 'agreement among raft nodes before linearized reading' (duration: 208.934534ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:57:43.108015Z","caller":"traceutil/trace.go:171","msg":"trace[1706011864] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"278.403658ms","start":"2026-04-07T12:57:42.829585Z","end":"2026-04-07T12:57:43.107989Z","steps":["trace[1706011864] 'process raft request' (duration: 241.573754ms)","trace[1706011864] 'compare' (duration: 36.67183ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:57:43.108318Z","caller":"traceutil/trace.go:171","msg":"trace[1681122769] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"208.400801ms","start":"2026-04-07T12:57:42.89989Z","end":"2026-04-07T12:57:43.108291Z","steps":["trace[1681122769] 'process raft request' (duration: 208.273227ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:57:43.108379Z","caller":"traceutil/trace.go:171","msg":"trace[146865353] linearizableReadLoop","detail":"{readStateIndex:2234; appliedIndex:2232; }","duration":"212.052302ms","start":"2026-04-07T12:57:42.896302Z","end":"2026-04-07T12:57:43.108354Z","steps":["trace[146865353] 'read index received' (duration: 174.856649ms)","trace[146865353] 'applied index is now lower than readState.Index' (duration: 37.193233ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:57:43.108444Z","caller":"traceutil/trace.go:171","msg":"trace[241920704] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"250.060285ms","start":"2026-04-07T12:57:42.858361Z","end":"2026-04-07T12:57:43.108421Z","steps":["trace[241920704] 'process raft request' (duration: 249.581243ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:57:43.108632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.381441ms","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-04-07T12:57:43.108709Z","caller":"traceutil/trace.go:171","msg":"trace[1783726366] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2154; }","duration":"337.506294ms","start":"2026-04-07T12:57:42.77119Z","end":"2026-04-07T12:57:43.108696Z","steps":["trace[1783726366] 'agreement among raft nodes before linearized reading' (duration: 337.296319ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T12:57:43.108771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T12:57:42.771172Z","time spent":"337.588776ms","remote":"127.0.0.1:47898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-04-07T12:58:18.974188Z","caller":"traceutil/trace.go:171","msg":"trace[1478336209] transaction","detail":"{read_only:false; response_revision:2521; number_of_response:1; }","duration":"103.359005ms","start":"2026-04-07T12:58:18.870806Z","end":"2026-04-07T12:58:18.974165Z","steps":["trace[1478336209] 'process raft request' (duration: 103.084198ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:58:55.823606Z","caller":"traceutil/trace.go:171","msg":"trace[2056463178] transaction","detail":"{read_only:false; response_revision:2746; number_of_response:1; }","duration":"108.788183ms","start":"2026-04-07T12:58:55.714797Z","end":"2026-04-07T12:58:55.823585Z","steps":["trace[2056463178] 'process raft request' (duration: 108.616769ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T12:58:56.05523Z","caller":"traceutil/trace.go:171","msg":"trace[1216408294] transaction","detail":"{read_only:false; response_revision:2747; number_of_response:1; }","duration":"227.110444ms","start":"2026-04-07T12:58:55.828098Z","end":"2026-04-07T12:58:56.055208Z","steps":["trace[1216408294] 'process raft request' (duration: 205.862435ms)","trace[1216408294] 'compare' (duration: 21.098955ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T12:58:56.055216Z","caller":"traceutil/trace.go:171","msg":"trace[294856669] linearizableReadLoop","detail":"{readStateIndex:2850; appliedIndex:2849; }","duration":"178.794108ms","start":"2026-04-07T12:58:55.876395Z","end":"2026-04-07T12:58:56.055189Z","steps":["trace[294856669] 'read index received' (duration: 157.623681ms)","trace[294856669] 'applied index is now lower than readState.Index' (duration: 21.169307ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T12:58:56.055441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.031854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.4\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-04-07T12:58:56.0555Z","caller":"traceutil/trace.go:171","msg":"trace[903926135] range","detail":"{range_begin:/registry/masterleases/199.204.45.4; range_end:; response_count:1; response_revision:2747; }","duration":"179.155976ms","start":"2026-04-07T12:58:55.87633Z","end":"2026-04-07T12:58:56.055486Z","steps":["trace[903926135] 'agreement among raft nodes before linearized reading' (duration: 178.950022ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:02:29.193289Z","caller":"traceutil/trace.go:171","msg":"trace[2046770021] linearizableReadLoop","detail":"{readStateIndex:4874; appliedIndex:4873; }","duration":"126.318955ms","start":"2026-04-07T13:02:29.066941Z","end":"2026-04-07T13:02:29.19326Z","steps":["trace[2046770021] 'read index received' (duration: 52.173276ms)","trace[2046770021] 'applied index is now lower than readState.Index' (duration: 74.144279ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T13:02:29.193374Z","caller":"traceutil/trace.go:171","msg":"trace[2098687569] transaction","detail":"{read_only:false; response_revision:4696; number_of_response:1; }","duration":"160.286735ms","start":"2026-04-07T13:02:29.033053Z","end":"2026-04-07T13:02:29.19334Z","steps":["trace[2098687569] 'process raft request' (duration: 86.046974ms)","trace[2098687569] 'compare' (duration: 74.040157ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T13:02:29.193572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.239939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-07T13:02:29.193629Z","caller":"traceutil/trace.go:171","msg":"trace[838884967] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4696; }","duration":"169.341532ms","start":"2026-04-07T13:02:29.024273Z","end":"2026-04-07T13:02:29.193615Z","steps":["trace[838884967] 'agreement among raft nodes before linearized reading' (duration: 169.131457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:02:29.193595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.677222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-p8fmn\" ","response":"range_response_count:1 size:6523"} {"level":"info","ts":"2026-04-07T13:02:29.193715Z","caller":"traceutil/trace.go:171","msg":"trace[783950627] range","detail":"{range_begin:/registry/pods/openstack/keepalived-p8fmn; range_end:; response_count:1; response_revision:4696; }","duration":"128.858336ms","start":"2026-04-07T13:02:29.064833Z","end":"2026-04-07T13:02:29.193692Z","steps":["trace[783950627] 'agreement among raft nodes before linearized reading' (duration: 128.518958ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:02:29.194001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.001909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-ggn9x-tls\" ","response":"range_response_count:1 size:4426"} {"level":"info","ts":"2026-04-07T13:02:29.194056Z","caller":"traceutil/trace.go:171","msg":"trace[107731248] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-ggn9x-tls; range_end:; response_count:1; response_revision:4696; }","duration":"173.074761ms","start":"2026-04-07T13:02:29.020969Z","end":"2026-04-07T13:02:29.194043Z","steps":["trace[107731248] 'agreement among raft nodes before linearized reading' (duration: 172.925647ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:02:29.219622Z","caller":"traceutil/trace.go:171","msg":"trace[658624467] transaction","detail":"{read_only:false; response_revision:4697; number_of_response:1; }","duration":"113.073139ms","start":"2026-04-07T13:02:29.106523Z","end":"2026-04-07T13:02:29.219597Z","steps":["trace[658624467] 'process raft request' (duration: 112.974976ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:02:29.219826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.127709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-04-07T13:02:29.219904Z","caller":"traceutil/trace.go:171","msg":"trace[86444603] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4697; }","duration":"149.220081ms","start":"2026-04-07T13:02:29.070664Z","end":"2026-04-07T13:02:29.219884Z","steps":["trace[86444603] 'agreement among raft nodes before linearized reading' (duration: 148.982816ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:02:29.21989Z","caller":"traceutil/trace.go:171","msg":"trace[1032211582] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4696; }","duration":"142.621973ms","start":"2026-04-07T13:02:29.077071Z","end":"2026-04-07T13:02:29.219693Z","steps":["trace[1032211582] 'process raft request' (duration: 142.351376ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:02:33.78753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.464836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-07T13:02:33.78762Z","caller":"traceutil/trace.go:171","msg":"trace[533593064] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4838; }","duration":"133.585638ms","start":"2026-04-07T13:02:33.654018Z","end":"2026-04-07T13:02:33.787603Z","steps":["trace[533593064] 'range keys from in-memory index tree' (duration: 133.330323ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:02:33.787712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.175399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-07T13:02:33.787778Z","caller":"traceutil/trace.go:171","msg":"trace[533624919] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4838; }","duration":"120.26929ms","start":"2026-04-07T13:02:33.667495Z","end":"2026-04-07T13:02:33.787764Z","steps":["trace[533624919] 'range keys from in-memory index tree' (duration: 120.104677ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:02:33.787896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.361035ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T13:02:33.78795Z","caller":"traceutil/trace.go:171","msg":"trace[1345242286] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:4838; }","duration":"113.419486ms","start":"2026-04-07T13:02:33.674524Z","end":"2026-04-07T13:02:33.787943Z","steps":["trace[1345242286] 'range keys from in-memory index tree' (duration: 113.356445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:02:33.788135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.5757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T13:02:33.788199Z","caller":"traceutil/trace.go:171","msg":"trace[136197951] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:0; response_revision:4838; }","duration":"149.686113ms","start":"2026-04-07T13:02:33.638487Z","end":"2026-04-07T13:02:33.788173Z","steps":["trace[136197951] 'range keys from in-memory index tree' (duration: 149.503919ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:02:34.226264Z","caller":"traceutil/trace.go:171","msg":"trace[794482300] transaction","detail":"{read_only:false; response_revision:4849; number_of_response:1; }","duration":"112.475165ms","start":"2026-04-07T13:02:34.113764Z","end":"2026-04-07T13:02:34.226239Z","steps":["trace[794482300] 'process raft request' (duration: 112.409094ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:02:34.2264Z","caller":"traceutil/trace.go:171","msg":"trace[448089247] transaction","detail":"{read_only:false; response_revision:4848; number_of_response:1; }","duration":"189.465952ms","start":"2026-04-07T13:02:34.036857Z","end":"2026-04-07T13:02:34.226323Z","steps":["trace[448089247] 'process raft request' (duration: 137.057921ms)","trace[448089247] 'compare' (duration: 52.094674ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T13:02:44.722644Z","caller":"traceutil/trace.go:171","msg":"trace[52802850] transaction","detail":"{read_only:false; response_revision:5064; number_of_response:1; }","duration":"109.349299ms","start":"2026-04-07T13:02:44.613261Z","end":"2026-04-07T13:02:44.72261Z","steps":["trace[52802850] 'process raft request' (duration: 33.812996ms)","trace[52802850] 'compare' (duration: 75.029612ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T13:02:52.407795Z","caller":"traceutil/trace.go:171","msg":"trace[630403051] transaction","detail":"{read_only:false; response_revision:5232; number_of_response:1; }","duration":"255.943259ms","start":"2026-04-07T13:02:52.151806Z","end":"2026-04-07T13:02:52.407749Z","steps":["trace[630403051] 'process raft request' (duration: 255.573801ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:02:52.433557Z","caller":"traceutil/trace.go:171","msg":"trace[1313158185] transaction","detail":"{read_only:false; response_revision:5233; number_of_response:1; }","duration":"149.347604ms","start":"2026-04-07T13:02:52.284175Z","end":"2026-04-07T13:02:52.433523Z","steps":["trace[1313158185] 'process raft request' (duration: 149.119789ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:02:52.610679Z","caller":"traceutil/trace.go:171","msg":"trace[419823149] linearizableReadLoop","detail":"{readStateIndex:5426; appliedIndex:5425; }","duration":"164.793983ms","start":"2026-04-07T13:02:52.445852Z","end":"2026-04-07T13:02:52.610646Z","steps":["trace[419823149] 'read index received' (duration: 164.550888ms)","trace[419823149] 'applied index is now lower than readState.Index' (duration: 241.695µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T13:02:52.610752Z","caller":"traceutil/trace.go:171","msg":"trace[2074182800] transaction","detail":"{read_only:false; response_revision:5234; number_of_response:1; }","duration":"169.331511ms","start":"2026-04-07T13:02:52.441373Z","end":"2026-04-07T13:02:52.610705Z","steps":["trace[2074182800] 'process raft request' (duration: 169.050684ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:02:52.610953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.0734ms","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-04-07T13:02:52.611018Z","caller":"traceutil/trace.go:171","msg":"trace[1346026143] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5234; }","duration":"165.209953ms","start":"2026-04-07T13:02:52.445792Z","end":"2026-04-07T13:02:52.611002Z","steps":["trace[1346026143] 'agreement among raft nodes before linearized reading' (duration: 164.979967ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:02:52.734761Z","caller":"traceutil/trace.go:171","msg":"trace[816004059] transaction","detail":"{read_only:false; response_revision:5235; number_of_response:1; }","duration":"118.064929ms","start":"2026-04-07T13:02:52.616673Z","end":"2026-04-07T13:02:52.734737Z","steps":["trace[816004059] 'process raft request' (duration: 117.895724ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:02:52.744409Z","caller":"traceutil/trace.go:171","msg":"trace[698665321] transaction","detail":"{read_only:false; response_revision:5236; number_of_response:1; }","duration":"127.542705ms","start":"2026-04-07T13:02:52.616824Z","end":"2026-04-07T13:02:52.744367Z","steps":["trace[698665321] 'process raft request' (duration: 127.34692ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:02:52.744673Z","caller":"traceutil/trace.go:171","msg":"trace[2039076039] transaction","detail":"{read_only:false; response_revision:5237; number_of_response:1; }","duration":"127.344019ms","start":"2026-04-07T13:02:52.617313Z","end":"2026-04-07T13:02:52.744657Z","steps":["trace[2039076039] 'process raft request' (duration: 126.984241ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:02:52.744929Z","caller":"traceutil/trace.go:171","msg":"trace[121209302] transaction","detail":"{read_only:false; response_revision:5238; number_of_response:1; }","duration":"127.121103ms","start":"2026-04-07T13:02:52.617746Z","end":"2026-04-07T13:02:52.744867Z","steps":["trace[121209302] 'process raft request' (duration: 126.726644ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:03:42.709162Z","caller":"traceutil/trace.go:171","msg":"trace[91223028] transaction","detail":"{read_only:false; response_revision:5728; number_of_response:1; }","duration":"112.540914ms","start":"2026-04-07T13:03:42.596588Z","end":"2026-04-07T13:03:42.709129Z","steps":["trace[91223028] 'process raft request' (duration: 112.279398ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:04:42.954055Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3002} {"level":"info","ts":"2026-04-07T13:04:43.057586Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3002,"took":"101.88738ms","hash":564212550,"current-db-size-bytes":58707968,"current-db-size":"59 MB","current-db-size-in-use-bytes":31502336,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-07T13:04:43.057651Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":564212550,"revision":3002,"compact-revision":-1} {"level":"info","ts":"2026-04-07T13:09:42.961471Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6104} {"level":"info","ts":"2026-04-07T13:09:43.063792Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6104,"took":"100.269635ms","hash":1968257999,"current-db-size-bytes":58707968,"current-db-size":"59 MB","current-db-size-in-use-bytes":23654400,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-07T13:09:43.063852Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1968257999,"revision":6104,"compact-revision":3002} {"level":"info","ts":"2026-04-07T13:09:53.502868Z","caller":"traceutil/trace.go:171","msg":"trace[1357253211] transaction","detail":"{read_only:false; response_revision:8348; number_of_response:1; }","duration":"211.093019ms","start":"2026-04-07T13:09:53.291744Z","end":"2026-04-07T13:09:53.502837Z","steps":["trace[1357253211] 'process raft request' (duration: 210.947256ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:09:53.520873Z","caller":"traceutil/trace.go:171","msg":"trace[280537591] transaction","detail":"{read_only:false; response_revision:8349; number_of_response:1; }","duration":"210.802802ms","start":"2026-04-07T13:09:53.310046Z","end":"2026-04-07T13:09:53.520849Z","steps":["trace[280537591] 'process raft request' (duration: 210.631408ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:09:53.521183Z","caller":"traceutil/trace.go:171","msg":"trace[2026588494] transaction","detail":"{read_only:false; response_revision:8350; number_of_response:1; }","duration":"174.691095ms","start":"2026-04-07T13:09:53.346464Z","end":"2026-04-07T13:09:53.521155Z","steps":["trace[2026588494] 'process raft request' (duration: 174.345696ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:09:53.521207Z","caller":"traceutil/trace.go:171","msg":"trace[944403] transaction","detail":"{read_only:false; response_revision:8351; number_of_response:1; }","duration":"105.834186ms","start":"2026-04-07T13:09:53.415348Z","end":"2026-04-07T13:09:53.521183Z","steps":["trace[944403] 'process raft request' (duration: 105.659912ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:09:54.118298Z","caller":"traceutil/trace.go:171","msg":"trace[1497088086] transaction","detail":"{read_only:false; response_revision:8356; number_of_response:1; }","duration":"102.200961ms","start":"2026-04-07T13:09:54.016066Z","end":"2026-04-07T13:09:54.118267Z","steps":["trace[1497088086] 'process raft request' (duration: 50.393768ms)","trace[1497088086] 'compare' (duration: 51.400343ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T13:10:21.85737Z","caller":"traceutil/trace.go:171","msg":"trace[775901415] transaction","detail":"{read_only:false; response_revision:8554; number_of_response:1; }","duration":"237.5886ms","start":"2026-04-07T13:10:21.619754Z","end":"2026-04-07T13:10:21.857343Z","steps":["trace[775901415] 'process raft request' (duration: 237.450776ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:10:22.062112Z","caller":"traceutil/trace.go:171","msg":"trace[490197170] linearizableReadLoop","detail":"{readStateIndex:8858; appliedIndex:8856; }","duration":"416.676838ms","start":"2026-04-07T13:10:21.645415Z","end":"2026-04-07T13:10:22.062092Z","steps":["trace[490197170] 'read index received' (duration: 212.474672ms)","trace[490197170] 'applied index is now lower than readState.Index' (duration: 204.201046ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T13:10:22.062486Z","caller":"traceutil/trace.go:171","msg":"trace[805485950] transaction","detail":"{read_only:false; response_revision:8555; number_of_response:1; }","duration":"439.05755ms","start":"2026-04-07T13:10:21.62339Z","end":"2026-04-07T13:10:22.062447Z","steps":["trace[805485950] 'process raft request' (duration: 438.535478ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:10:22.062498Z","caller":"traceutil/trace.go:171","msg":"trace[202023848] transaction","detail":"{read_only:false; response_revision:8556; number_of_response:1; }","duration":"439.0453ms","start":"2026-04-07T13:10:21.623427Z","end":"2026-04-07T13:10:22.062472Z","steps":["trace[202023848] 'process raft request' (duration: 438.62112ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:10:22.062495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.051897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T13:10:22.062618Z","caller":"traceutil/trace.go:171","msg":"trace[1721950688] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:8556; }","duration":"417.19059ms","start":"2026-04-07T13:10:21.645409Z","end":"2026-04-07T13:10:22.062599Z","steps":["trace[1721950688] 'agreement among raft nodes before linearized reading' (duration: 416.996705ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:10:22.062671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T13:10:21.645341Z","time spent":"417.320323ms","remote":"127.0.0.1:48368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":30,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-07T13:10:22.062665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T13:10:21.623367Z","time spent":"439.200953ms","remote":"127.0.0.1:48324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T13:10:22.06272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.176057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-p8fmn\" ","response":"range_response_count:1 size:6523"} {"level":"warn","ts":"2026-04-07T13:10:22.06278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.225801ms","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-04-07T13:10:22.062805Z","caller":"traceutil/trace.go:171","msg":"trace[878751587] range","detail":"{range_begin:/registry/pods/openstack/keepalived-p8fmn; range_end:; response_count:1; response_revision:8556; }","duration":"276.29499ms","start":"2026-04-07T13:10:21.786488Z","end":"2026-04-07T13:10:22.062783Z","steps":["trace[878751587] 'agreement among raft nodes before linearized reading' (duration: 276.080595ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:10:22.062822Z","caller":"traceutil/trace.go:171","msg":"trace[43290088] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8556; }","duration":"327.292183ms","start":"2026-04-07T13:10:21.735518Z","end":"2026-04-07T13:10:22.06281Z","steps":["trace[43290088] 'agreement among raft nodes before linearized reading' (duration: 327.067628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:10:22.062853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T13:10:21.735507Z","time spent":"327.339374ms","remote":"127.0.0.1:48324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-07T13:10:22.062959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T13:10:21.623417Z","time spent":"439.143982ms","remote":"127.0.0.1:48324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T13:10:22.063141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.290414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-07T13:10:22.063193Z","caller":"traceutil/trace.go:171","msg":"trace[273513232] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8556; }","duration":"407.377867ms","start":"2026-04-07T13:10:21.6558Z","end":"2026-04-07T13:10:22.063178Z","steps":["trace[273513232] 'agreement among raft nodes before linearized reading' (duration: 406.710871ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:10:22.063228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T13:10:21.65579Z","time spent":"407.431057ms","remote":"127.0.0.1:48324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-07T13:10:34.269161Z","caller":"traceutil/trace.go:171","msg":"trace[873017638] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8658; }","duration":"157.026294ms","start":"2026-04-07T13:10:34.112106Z","end":"2026-04-07T13:10:34.269133Z","steps":["trace[873017638] 'process raft request' (duration: 94.930738ms)","trace[873017638] 'compare' (duration: 61.879851ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T13:10:34.269164Z","caller":"traceutil/trace.go:171","msg":"trace[1451990131] linearizableReadLoop","detail":"{readStateIndex:8967; appliedIndex:8964; }","duration":"118.595099ms","start":"2026-04-07T13:10:34.150548Z","end":"2026-04-07T13:10:34.269143Z","steps":["trace[1451990131] 'read index received' (duration: 11.683887ms)","trace[1451990131] 'applied index is now lower than readState.Index' (duration: 106.909982ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T13:10:34.269394Z","caller":"traceutil/trace.go:171","msg":"trace[126108883] transaction","detail":"{read_only:false; response_revision:8660; number_of_response:1; }","duration":"133.821381ms","start":"2026-04-07T13:10:34.135562Z","end":"2026-04-07T13:10:34.269383Z","steps":["trace[126108883] 'process raft request' (duration: 133.533834ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:10:34.269225Z","caller":"traceutil/trace.go:171","msg":"trace[1976857342] transaction","detail":"{read_only:false; response_revision:8659; number_of_response:1; }","duration":"141.071594ms","start":"2026-04-07T13:10:34.128126Z","end":"2026-04-07T13:10:34.269198Z","steps":["trace[1976857342] 'process raft request' (duration: 140.91285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:10:34.269354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.788455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-07T13:10:34.269644Z","caller":"traceutil/trace.go:171","msg":"trace[797989677] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8660; }","duration":"119.008789ms","start":"2026-04-07T13:10:34.150513Z","end":"2026-04-07T13:10:34.269522Z","steps":["trace[797989677] 'agreement among raft nodes before linearized reading' (duration: 118.705652ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:10:34.272335Z","caller":"traceutil/trace.go:171","msg":"trace[2067101851] transaction","detail":"{read_only:false; response_revision:8661; number_of_response:1; }","duration":"108.51215ms","start":"2026-04-07T13:10:34.163807Z","end":"2026-04-07T13:10:34.272319Z","steps":["trace[2067101851] 'process raft request' (duration: 108.359266ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:10:34.284009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.01902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-p8fmn\" ","response":"range_response_count:1 size:6523"} {"level":"info","ts":"2026-04-07T13:10:34.284054Z","caller":"traceutil/trace.go:171","msg":"trace[145570256] range","detail":"{range_begin:/registry/pods/openstack/keepalived-p8fmn; range_end:; response_count:1; response_revision:8662; }","duration":"103.067311ms","start":"2026-04-07T13:10:34.180977Z","end":"2026-04-07T13:10:34.284044Z","steps":["trace[145570256] 'agreement among raft nodes before linearized reading' (duration: 102.951919ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T13:10:34.284207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.919409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-07T13:10:34.28431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.229385ms","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-04-07T13:10:34.284452Z","caller":"traceutil/trace.go:171","msg":"trace[653845329] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8662; }","duration":"111.356878ms","start":"2026-04-07T13:10:34.173052Z","end":"2026-04-07T13:10:34.284409Z","steps":["trace[653845329] 'agreement among raft nodes before linearized reading' (duration: 111.169294ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:10:34.284307Z","caller":"traceutil/trace.go:171","msg":"trace[1114981817] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8662; }","duration":"106.078062ms","start":"2026-04-07T13:10:34.178211Z","end":"2026-04-07T13:10:34.284289Z","steps":["trace[1114981817] 'agreement among raft nodes before linearized reading' (duration: 105.754515ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:10:34.985529Z","caller":"traceutil/trace.go:171","msg":"trace[897217767] transaction","detail":"{read_only:false; response_revision:8670; number_of_response:1; }","duration":"177.140412ms","start":"2026-04-07T13:10:34.808237Z","end":"2026-04-07T13:10:34.985377Z","steps":["trace[897217767] 'process raft request' (duration: 176.805185ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:10:35.587642Z","caller":"traceutil/trace.go:171","msg":"trace[1021721899] transaction","detail":"{read_only:false; response_revision:8674; number_of_response:1; }","duration":"161.571092ms","start":"2026-04-07T13:10:35.426043Z","end":"2026-04-07T13:10:35.587614Z","steps":["trace[1021721899] 'process raft request' (duration: 161.380528ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:10:51.16611Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023d9.wal"} {"level":"info","ts":"2026-04-07T13:11:49.56399Z","caller":"traceutil/trace.go:171","msg":"trace[18085977] transaction","detail":"{read_only:false; response_revision:9414; number_of_response:1; }","duration":"211.069816ms","start":"2026-04-07T13:11:49.352895Z","end":"2026-04-07T13:11:49.563964Z","steps":["trace[18085977] 'process raft request' (duration: 210.911222ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T13:12:23.665397Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"66f7b57d56ad567d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-07T13:12:23.671291Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-07T13:12:23.671403Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-07T13:14:42.967831Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8295} {"level":"info","ts":"2026-04-07T13:14:43.043795Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8295,"took":"73.845279ms","hash":2506951455,"current-db-size-bytes":58707968,"current-db-size":"59 MB","current-db-size-in-use-bytes":25497600,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-04-07T13:14:43.043871Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2506951455,"revision":8295,"compact-revision":6104} {"level":"info","ts":"2026-04-07T13:19:42.972183Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10693} {"level":"info","ts":"2026-04-07T13:19:43.058402Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10693,"took":"84.231976ms","hash":2410405044,"current-db-size-bytes":58707968,"current-db-size":"59 MB","current-db-size-in-use-bytes":20955136,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-07T13:19:43.058482Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2410405044,"revision":10693,"compact-revision":8295}