{"level":"warn","ts":"2026-05-21T00:24:25.634118Z","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-21T00:24:25.634272Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.229: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.229:2380","--initial-cluster=instance=https://199.204.45.229:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.229:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.229: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-21T00:24:25.634373Z","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-21T00:24:25.634386Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-05-21T00:24:25.634419Z","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-21T00:24:25.635256Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"]} {"level":"info","ts":"2026-05-21T00:24:25.635362Z","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.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.229: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-21T00:24:25.639951Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.305847ms"} {"level":"info","ts":"2026-05-21T00:24:25.65365Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3ba9ae53cc4335db","cluster-id":"4ad2674607ff1d60"} {"level":"info","ts":"2026-05-21T00:24:25.653778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=()"} {"level":"info","ts":"2026-05-21T00:24:25.653845Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 0"} {"level":"info","ts":"2026-05-21T00:24:25.654316Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3ba9ae53cc4335db [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-21T00:24:25.654397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 1"} {"level":"info","ts":"2026-05-21T00:24:25.654454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"warn","ts":"2026-05-21T00:24:25.660379Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-21T00:24:25.661931Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-21T00:24:25.663412Z","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-21T00:24:25.665672Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3ba9ae53cc4335db","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-21T00:24:25.66589Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3ba9ae53cc4335db","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-21T00:24:25.666136Z","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-21T00:24:25.666223Z","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-21T00:24:25.66624Z","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-21T00:24:25.668408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"info","ts":"2026-05-21T00:24:25.668678Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","added-peer-id":"3ba9ae53cc4335db","added-peer-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-05-21T00:24:25.670654Z","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-21T00:24:25.670813Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-05-21T00:24:25.670887Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-05-21T00:24:25.670977Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3ba9ae53cc4335db","initial-advertise-peer-urls":["https://199.204.45.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-21T00:24:25.671023Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-21T00:24:26.258588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db is starting a new election at term 1"} {"level":"info","ts":"2026-05-21T00:24:26.258664Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became pre-candidate at term 1"} {"level":"info","ts":"2026-05-21T00:24:26.258683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgPreVoteResp from 3ba9ae53cc4335db at term 1"} {"level":"info","ts":"2026-05-21T00:24:26.258698Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became candidate at term 2"} {"level":"info","ts":"2026-05-21T00:24:26.258705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgVoteResp from 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-05-21T00:24:26.258715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became leader at term 2"} {"level":"info","ts":"2026-05-21T00:24:26.258723Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3ba9ae53cc4335db elected leader 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-05-21T00:24:26.266782Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T00:24:26.274974Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3ba9ae53cc4335db","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.229:2379]}","request-path":"/0/members/3ba9ae53cc4335db/attributes","cluster-id":"4ad2674607ff1d60","publish-timeout":"7s"} {"level":"info","ts":"2026-05-21T00:24:26.275024Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-21T00:24:26.275069Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-21T00:24:26.275515Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-21T00:24:26.275566Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-21T00:24:26.278909Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.229:2379"} {"level":"info","ts":"2026-05-21T00:24:26.279527Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-21T00:24:26.282618Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T00:24:26.282756Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T00:24:26.282852Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T00:25:09.854614Z","caller":"traceutil/trace.go:171","msg":"trace[877161444] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"146.826588ms","start":"2026-05-21T00:25:09.707758Z","end":"2026-05-21T00:25:09.854585Z","steps":["trace[877161444] 'process raft request' (duration: 146.348556ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:25:10.783741Z","caller":"traceutil/trace.go:171","msg":"trace[1785568150] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"341.022506ms","start":"2026-05-21T00:25:10.442691Z","end":"2026-05-21T00:25:10.783714Z","steps":["trace[1785568150] 'read index received' (duration: 340.242077ms)","trace[1785568150] 'applied index is now lower than readState.Index' (duration: 779.749µs)"],"step_count":2} {"level":"info","ts":"2026-05-21T00:25:10.783846Z","caller":"traceutil/trace.go:171","msg":"trace[285764629] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"448.441474ms","start":"2026-05-21T00:25:10.335362Z","end":"2026-05-21T00:25:10.783803Z","steps":["trace[285764629] 'process raft request' (duration: 447.804609ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:25:10.783897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.199521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-21T00:25:10.784128Z","caller":"traceutil/trace.go:171","msg":"trace[2039792837] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:627; }","duration":"341.489588ms","start":"2026-05-21T00:25:10.442627Z","end":"2026-05-21T00:25:10.784116Z","steps":["trace[2039792837] 'agreement among raft nodes before linearized reading' (duration: 341.210021ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:25:10.784205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T00:25:10.442594Z","time spent":"341.553079ms","remote":"127.0.0.1:50632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-21T00:25:10.7846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T00:25:10.335333Z","time spent":"448.605758ms","remote":"127.0.0.1:50456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036105,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T00:25:26.401569Z","caller":"traceutil/trace.go:171","msg":"trace[82603136] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"108.115764ms","start":"2026-05-21T00:25:26.293424Z","end":"2026-05-21T00:25:26.40154Z","steps":["trace[82603136] 'process raft request' (duration: 107.92083ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:25:55.000103Z","caller":"traceutil/trace.go:171","msg":"trace[1015087676] linearizableReadLoop","detail":"{readStateIndex:1233; appliedIndex:1232; }","duration":"167.114488ms","start":"2026-05-21T00:25:54.832954Z","end":"2026-05-21T00:25:55.000069Z","steps":["trace[1015087676] 'read index received' (duration: 118.346481ms)","trace[1015087676] 'applied index is now lower than readState.Index' (duration: 48.765897ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T00:25:55.000358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.349733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T00:25:55.000492Z","caller":"traceutil/trace.go:171","msg":"trace[683350952] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1194; }","duration":"167.563338ms","start":"2026-05-21T00:25:54.832904Z","end":"2026-05-21T00:25:55.000467Z","steps":["trace[683350952] 'agreement among raft nodes before linearized reading' (duration: 167.278801ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:26:11.647143Z","caller":"traceutil/trace.go:171","msg":"trace[1066623727] transaction","detail":"{read_only:false; response_revision:1337; number_of_response:1; }","duration":"106.664822ms","start":"2026-05-21T00:26:11.540439Z","end":"2026-05-21T00:26:11.647104Z","steps":["trace[1066623727] 'process raft request' (duration: 106.441566ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:26:45.420769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.088553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-99143b53-de37-43d7-94dc-9a8d0faea9c3\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-21T00:26:45.420865Z","caller":"traceutil/trace.go:171","msg":"trace[428228535] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-99143b53-de37-43d7-94dc-9a8d0faea9c3; range_end:; response_count:1; response_revision:1881; }","duration":"235.247667ms","start":"2026-05-21T00:26:45.185597Z","end":"2026-05-21T00:26:45.420845Z","steps":["trace[428228535] 'range keys from in-memory index tree' (duration: 234.879219ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:26:45.420909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.580274ms","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-21T00:26:45.420992Z","caller":"traceutil/trace.go:171","msg":"trace[79922513] linearizableReadLoop","detail":"{readStateIndex:1958; appliedIndex:1957; }","duration":"152.637331ms","start":"2026-05-21T00:26:45.268316Z","end":"2026-05-21T00:26:45.420953Z","steps":["trace[79922513] 'read index received' (duration: 124.754674ms)","trace[79922513] 'applied index is now lower than readState.Index' (duration: 27.881477ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T00:26:45.421011Z","caller":"traceutil/trace.go:171","msg":"trace[2044674103] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1881; }","duration":"273.738138ms","start":"2026-05-21T00:26:45.147248Z","end":"2026-05-21T00:26:45.420986Z","steps":["trace[2044674103] 'range keys from in-memory index tree' (duration: 273.371989ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:26:45.421036Z","caller":"traceutil/trace.go:171","msg":"trace[385676758] transaction","detail":"{read_only:false; response_revision:1882; number_of_response:1; }","duration":"225.812642ms","start":"2026-05-21T00:26:45.195175Z","end":"2026-05-21T00:26:45.420988Z","steps":["trace[385676758] 'process raft request' (duration: 197.988956ms)","trace[385676758] 'compare' (duration: 27.392926ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T00:26:45.421749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.41694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T00:26:45.421844Z","caller":"traceutil/trace.go:171","msg":"trace[979957626] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1882; }","duration":"153.566034ms","start":"2026-05-21T00:26:45.268256Z","end":"2026-05-21T00:26:45.421822Z","steps":["trace[979957626] 'agreement among raft nodes before linearized reading' (duration: 152.827526ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:27:35.576023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.834529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-21T00:27:35.576712Z","caller":"traceutil/trace.go:171","msg":"trace[215847419] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:2204; }","duration":"161.593828ms","start":"2026-05-21T00:27:35.415097Z","end":"2026-05-21T00:27:35.576691Z","steps":["trace[215847419] 'count revisions from in-memory index tree' (duration: 160.697326ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:27:35.59939Z","caller":"traceutil/trace.go:171","msg":"trace[99467] transaction","detail":"{read_only:false; response_revision:2205; number_of_response:1; }","duration":"135.192302ms","start":"2026-05-21T00:27:35.464173Z","end":"2026-05-21T00:27:35.599365Z","steps":["trace[99467] 'process raft request' (duration: 133.992433ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:27:41.388052Z","caller":"traceutil/trace.go:171","msg":"trace[1636342792] transaction","detail":"{read_only:false; response_revision:2236; number_of_response:1; }","duration":"111.357746ms","start":"2026-05-21T00:27:41.276663Z","end":"2026-05-21T00:27:41.388021Z","steps":["trace[1636342792] 'process raft request' (duration: 111.214822ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:27:42.454479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.584546ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T00:27:42.454787Z","caller":"traceutil/trace.go:171","msg":"trace[1265142536] transaction","detail":"{read_only:false; response_revision:2240; number_of_response:1; }","duration":"321.851413ms","start":"2026-05-21T00:27:42.132916Z","end":"2026-05-21T00:27:42.454767Z","steps":["trace[1265142536] 'process raft request' (duration: 321.776172ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:27:42.454863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T00:27:42.132888Z","time spent":"321.941575ms","remote":"127.0.0.1:50632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T00:27:42.454987Z","caller":"traceutil/trace.go:171","msg":"trace[275167265] transaction","detail":"{read_only:false; response_revision:2239; number_of_response:1; }","duration":"545.299143ms","start":"2026-05-21T00:27:41.909647Z","end":"2026-05-21T00:27:42.454946Z","steps":["trace[275167265] 'process raft request' (duration: 544.962405ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:27:42.455049Z","caller":"traceutil/trace.go:171","msg":"trace[1964335350] transaction","detail":"{read_only:false; response_revision:2238; number_of_response:1; }","duration":"545.6185ms","start":"2026-05-21T00:27:41.909367Z","end":"2026-05-21T00:27:42.454986Z","steps":["trace[1964335350] 'process raft request' (duration: 386.203866ms)","trace[1964335350] 'compare' (duration: 158.256837ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T00:27:42.455168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T00:27:41.909618Z","time spent":"545.464567ms","remote":"127.0.0.1:50632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T00:27:42.455288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T00:27:41.909342Z","time spent":"545.786284ms","remote":"127.0.0.1:50632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T00:27:42.68943Z","caller":"traceutil/trace.go:171","msg":"trace[523110300] transaction","detail":"{read_only:false; response_revision:2241; number_of_response:1; }","duration":"187.855461ms","start":"2026-05-21T00:27:42.501543Z","end":"2026-05-21T00:27:42.689399Z","steps":["trace[523110300] 'process raft request' (duration: 106.224931ms)","trace[523110300] 'compare' (duration: 81.510137ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T00:28:50.48907Z","caller":"traceutil/trace.go:171","msg":"trace[1475393243] transaction","detail":"{read_only:false; response_revision:2806; number_of_response:1; }","duration":"148.453127ms","start":"2026-05-21T00:28:50.340593Z","end":"2026-05-21T00:28:50.489046Z","steps":["trace[1475393243] 'process raft request' (duration: 148.296893ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:31:25.955891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.194863ms","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-05-21T00:31:25.955961Z","caller":"traceutil/trace.go:171","msg":"trace[1929921460] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3826; }","duration":"114.297045ms","start":"2026-05-21T00:31:25.84165Z","end":"2026-05-21T00:31:25.955947Z","steps":["trace[1929921460] 'range keys from in-memory index tree' (duration: 114.04674ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:31:25.956041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.370308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-alertmanager-client-secret\" ","response":"range_response_count:1 size:698"} {"level":"info","ts":"2026-05-21T00:31:25.956217Z","caller":"traceutil/trace.go:171","msg":"trace[886715834] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-alertmanager-client-secret; range_end:; response_count:1; response_revision:3826; }","duration":"149.616944ms","start":"2026-05-21T00:31:25.806546Z","end":"2026-05-21T00:31:25.956163Z","steps":["trace[886715834] 'range keys from in-memory index tree' (duration: 149.185303ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:32:53.486948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.757835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-21T00:32:53.487022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.305947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"info","ts":"2026-05-21T00:32:53.48707Z","caller":"traceutil/trace.go:171","msg":"trace[1149032071] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4828; }","duration":"105.955999ms","start":"2026-05-21T00:32:53.381088Z","end":"2026-05-21T00:32:53.487044Z","steps":["trace[1149032071] 'range keys from in-memory index tree' (duration: 105.649952ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:32:53.487105Z","caller":"traceutil/trace.go:171","msg":"trace[1579756840] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4828; }","duration":"130.422789ms","start":"2026-05-21T00:32:53.356663Z","end":"2026-05-21T00:32:53.487086Z","steps":["trace[1579756840] 'range keys from in-memory index tree' (duration: 130.054031ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:32:59.745138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.885155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-21T00:32:59.745164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.557956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"info","ts":"2026-05-21T00:32:59.745263Z","caller":"traceutil/trace.go:171","msg":"trace[1792895760] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:5055; }","duration":"103.09483ms","start":"2026-05-21T00:32:59.642142Z","end":"2026-05-21T00:32:59.745237Z","steps":["trace[1792895760] 'count revisions from in-memory index tree' (duration: 102.704791ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:32:59.745238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.544174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-21T00:32:59.745296Z","caller":"traceutil/trace.go:171","msg":"trace[1713382549] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:5055; }","duration":"109.754731ms","start":"2026-05-21T00:32:59.635513Z","end":"2026-05-21T00:32:59.745268Z","steps":["trace[1713382549] 'range keys from in-memory index tree' (duration: 109.318401ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:32:59.745365Z","caller":"traceutil/trace.go:171","msg":"trace[1150540216] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:5055; }","duration":"287.728339ms","start":"2026-05-21T00:32:59.457609Z","end":"2026-05-21T00:32:59.745337Z","steps":["trace[1150540216] 'range keys from in-memory index tree' (duration: 287.295258ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:32:59.745153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.689081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-84ca4ad0-2fe0-4353-9da4-aa9e8242e75e\" ","response":"range_response_count:1 size:3601"} {"level":"warn","ts":"2026-05-21T00:32:59.745567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.654934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:779409"} {"level":"info","ts":"2026-05-21T00:32:59.745621Z","caller":"traceutil/trace.go:171","msg":"trace[1134851428] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-84ca4ad0-2fe0-4353-9da4-aa9e8242e75e; range_end:; response_count:1; response_revision:5055; }","duration":"219.256485ms","start":"2026-05-21T00:32:59.526343Z","end":"2026-05-21T00:32:59.7456Z","steps":["trace[1134851428] 'range keys from in-memory index tree' (duration: 218.427026ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:32:59.745654Z","caller":"traceutil/trace.go:171","msg":"trace[1799749692] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5055; }","duration":"272.796678ms","start":"2026-05-21T00:32:59.472838Z","end":"2026-05-21T00:32:59.745635Z","steps":["trace[1799749692] 'range keys from in-memory index tree' (duration: 272.111921ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:33:00.152147Z","caller":"traceutil/trace.go:171","msg":"trace[1056526174] transaction","detail":"{read_only:false; response_revision:5060; number_of_response:1; }","duration":"162.367571ms","start":"2026-05-21T00:32:59.989746Z","end":"2026-05-21T00:33:00.152114Z","steps":["trace[1056526174] 'process raft request' (duration: 126.558737ms)","trace[1056526174] 'compare' (duration: 35.467586ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T00:33:10.85724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.644698ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T00:33:10.857332Z","caller":"traceutil/trace.go:171","msg":"trace[960497835] linearizableReadLoop","detail":"{readStateIndex:5466; appliedIndex:5465; }","duration":"116.341411ms","start":"2026-05-21T00:33:10.740979Z","end":"2026-05-21T00:33:10.857321Z","steps":["trace[960497835] 'read index received' (duration: 6.474977ms)","trace[960497835] 'applied index is now lower than readState.Index' (duration: 109.865424ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T00:33:10.857396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.424512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/memcached-metrics\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T00:33:10.857422Z","caller":"traceutil/trace.go:171","msg":"trace[704779307] range","detail":"{range_begin:/registry/services/specs/openstack/memcached-metrics; range_end:; response_count:0; response_revision:5267; }","duration":"116.484174ms","start":"2026-05-21T00:33:10.740932Z","end":"2026-05-21T00:33:10.857416Z","steps":["trace[704779307] 'agreement among raft nodes before linearized reading' (duration: 116.418202ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:33:10.85764Z","caller":"traceutil/trace.go:171","msg":"trace[1159361754] transaction","detail":"{read_only:false; response_revision:5267; number_of_response:1; }","duration":"156.10441ms","start":"2026-05-21T00:33:10.701528Z","end":"2026-05-21T00:33:10.857633Z","steps":["trace[1159361754] 'process raft request' (duration: 45.997361ms)","trace[1159361754] 'compare' (duration: 109.525445ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T00:33:10.97943Z","caller":"traceutil/trace.go:171","msg":"trace[879870587] transaction","detail":"{read_only:false; response_revision:5268; number_of_response:1; }","duration":"108.049939ms","start":"2026-05-21T00:33:10.87136Z","end":"2026-05-21T00:33:10.97941Z","steps":["trace[879870587] 'process raft request' (duration: 107.836314ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:33:19.369952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.323248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T00:33:19.370055Z","caller":"traceutil/trace.go:171","msg":"trace[1412691516] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5444; }","duration":"101.486822ms","start":"2026-05-21T00:33:19.26855Z","end":"2026-05-21T00:33:19.370037Z","steps":["trace[1412691516] 'range keys from in-memory index tree' (duration: 101.112313ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:34:26.305391Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3002} {"level":"info","ts":"2026-05-21T00:34:26.391162Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3002,"took":"83.745248ms","hash":3303261631,"current-db-size-bytes":57913344,"current-db-size":"58 MB","current-db-size-in-use-bytes":31322112,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-05-21T00:34:26.391237Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3303261631,"revision":3002,"compact-revision":-1} {"level":"warn","ts":"2026-05-21T00:39:26.658352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.760154ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T00:39:26.658562Z","caller":"traceutil/trace.go:171","msg":"trace[1113914265] transaction","detail":"{read_only:false; response_revision:8286; number_of_response:1; }","duration":"399.792673ms","start":"2026-05-21T00:39:26.258701Z","end":"2026-05-21T00:39:26.658494Z","steps":["trace[1113914265] 'process raft request' (duration: 239.777843ms)","trace[1113914265] 'compare' (duration: 159.6164ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T00:39:26.658688Z","caller":"traceutil/trace.go:171","msg":"trace[549638118] transaction","detail":"{read_only:false; response_revision:8287; number_of_response:1; }","duration":"351.244333ms","start":"2026-05-21T00:39:26.307426Z","end":"2026-05-21T00:39:26.65867Z","steps":["trace[549638118] 'process raft request' (duration: 351.078839ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:39:26.658682Z","caller":"traceutil/trace.go:171","msg":"trace[500282335] linearizableReadLoop","detail":"{readStateIndex:8581; appliedIndex:8580; }","duration":"377.2221ms","start":"2026-05-21T00:39:26.281423Z","end":"2026-05-21T00:39:26.658645Z","steps":["trace[500282335] 'read index received' (duration: 217.069296ms)","trace[500282335] 'applied index is now lower than readState.Index' (duration: 160.149334ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T00:39:26.658726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T00:39:26.258672Z","time spent":"399.966798ms","remote":"127.0.0.1:50632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T00:39:26.658809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T00:39:26.307404Z","time spent":"351.341935ms","remote":"127.0.0.1:50378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":25,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T00:39:26.658991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.909052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-21T00:39:26.65904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.204788ms","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-05-21T00:39:26.65909Z","caller":"traceutil/trace.go:171","msg":"trace[1569338550] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8287; }","duration":"365.062437ms","start":"2026-05-21T00:39:26.293999Z","end":"2026-05-21T00:39:26.659061Z","steps":["trace[1569338550] 'agreement among raft nodes before linearized reading' (duration: 364.909183ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:39:26.659095Z","caller":"traceutil/trace.go:171","msg":"trace[862034271] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8287; }","duration":"139.3052ms","start":"2026-05-21T00:39:26.519774Z","end":"2026-05-21T00:39:26.659079Z","steps":["trace[862034271] 'agreement among raft nodes before linearized reading' (duration: 139.101765ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:39:26.65911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.099156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-05-21T00:39:26.659141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T00:39:26.293971Z","time spent":"365.162408ms","remote":"127.0.0.1:50844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":27,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-05-21T00:39:26.659155Z","caller":"traceutil/trace.go:171","msg":"trace[547596535] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8287; }","duration":"372.183588ms","start":"2026-05-21T00:39:26.286959Z","end":"2026-05-21T00:39:26.659142Z","steps":["trace[547596535] 'agreement among raft nodes before linearized reading' (duration: 371.86664ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:39:26.659143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.717781ms","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-05-21T00:39:26.659231Z","caller":"traceutil/trace.go:171","msg":"trace[804209738] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8287; }","duration":"377.848584ms","start":"2026-05-21T00:39:26.281361Z","end":"2026-05-21T00:39:26.65921Z","steps":["trace[804209738] 'agreement among raft nodes before linearized reading' (duration: 377.459595ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:39:26.659295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T00:39:26.281329Z","time spent":"377.952837ms","remote":"127.0.0.1:50632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-21T00:39:26.659225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T00:39:26.286946Z","time spent":"372.262299ms","remote":"127.0.0.1:50632","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-21T00:39:26.662921Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6065} {"level":"info","ts":"2026-05-21T00:39:26.768113Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6065,"took":"102.151665ms","hash":2536316592,"current-db-size-bytes":57913344,"current-db-size":"58 MB","current-db-size-in-use-bytes":23777280,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-05-21T00:39:26.768198Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2536316592,"revision":6065,"compact-revision":3002} {"level":"info","ts":"2026-05-21T00:39:38.50836Z","caller":"traceutil/trace.go:171","msg":"trace[1409018827] transaction","detail":"{read_only:false; response_revision:8349; number_of_response:1; }","duration":"221.75741ms","start":"2026-05-21T00:39:38.286572Z","end":"2026-05-21T00:39:38.50833Z","steps":["trace[1409018827] 'process raft request' (duration: 159.667901ms)","trace[1409018827] 'compare' (duration: 61.953586ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T00:40:00.994843Z","caller":"traceutil/trace.go:171","msg":"trace[758741968] linearizableReadLoop","detail":"{readStateIndex:8782; appliedIndex:8781; }","duration":"116.07665ms","start":"2026-05-21T00:40:00.878736Z","end":"2026-05-21T00:40:00.994813Z","steps":["trace[758741968] 'read index received' (duration: 16.515878ms)","trace[758741968] 'applied index is now lower than readState.Index' (duration: 99.559172ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T00:40:00.994928Z","caller":"traceutil/trace.go:171","msg":"trace[1826489932] transaction","detail":"{read_only:false; response_revision:8478; number_of_response:1; }","duration":"118.822267ms","start":"2026-05-21T00:40:00.876069Z","end":"2026-05-21T00:40:00.994891Z","steps":["trace[1826489932] 'process raft request' (duration: 19.269345ms)","trace[1826489932] 'compare' (duration: 99.295165ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T00:40:00.995115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.355967ms","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-05-21T00:40:00.995172Z","caller":"traceutil/trace.go:171","msg":"trace[338380408] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8478; }","duration":"116.450669ms","start":"2026-05-21T00:40:00.878709Z","end":"2026-05-21T00:40:00.99516Z","steps":["trace[338380408] 'agreement among raft nodes before linearized reading' (duration: 116.257955ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:40:00.995358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.015177ms","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-21T00:40:00.995418Z","caller":"traceutil/trace.go:171","msg":"trace[1925305621] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8478; }","duration":"113.112909ms","start":"2026-05-21T00:40:00.882289Z","end":"2026-05-21T00:40:00.995402Z","steps":["trace[1925305621] 'agreement among raft nodes before linearized reading' (duration: 112.978886ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:40:10.986447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.253495ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T00:40:10.986662Z","caller":"traceutil/trace.go:171","msg":"trace[351773417] transaction","detail":"{read_only:false; response_revision:8578; number_of_response:1; }","duration":"152.188551ms","start":"2026-05-21T00:40:10.834436Z","end":"2026-05-21T00:40:10.986624Z","steps":["trace[351773417] 'process raft request' (duration: 42.656079ms)","trace[351773417] 'compare' (duration: 109.100402ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T00:40:21.225095Z","caller":"traceutil/trace.go:171","msg":"trace[9479300] transaction","detail":"{read_only:false; response_revision:8676; number_of_response:1; }","duration":"120.477486ms","start":"2026-05-21T00:40:21.10459Z","end":"2026-05-21T00:40:21.225067Z","steps":["trace[9479300] 'process raft request' (duration: 41.992943ms)","trace[9479300] 'compare' (duration: 78.195867ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T00:40:21.374291Z","caller":"traceutil/trace.go:171","msg":"trace[1507889545] transaction","detail":"{read_only:false; response_revision:8678; number_of_response:1; }","duration":"144.370312ms","start":"2026-05-21T00:40:21.229883Z","end":"2026-05-21T00:40:21.374253Z","steps":["trace[1507889545] 'process raft request' (duration: 144.076705ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:40:21.374309Z","caller":"traceutil/trace.go:171","msg":"trace[183660165] transaction","detail":"{read_only:false; response_revision:8679; number_of_response:1; }","duration":"143.707406ms","start":"2026-05-21T00:40:21.230578Z","end":"2026-05-21T00:40:21.374285Z","steps":["trace[183660165] 'process raft request' (duration: 143.597764ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:40:21.505245Z","caller":"traceutil/trace.go:171","msg":"trace[1560394435] transaction","detail":"{read_only:false; response_revision:8680; number_of_response:1; }","duration":"114.943273ms","start":"2026-05-21T00:40:21.390271Z","end":"2026-05-21T00:40:21.505214Z","steps":["trace[1560394435] 'process raft request' (duration: 74.145178ms)","trace[1560394435] 'compare' (duration: 40.518038ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T00:40:42.632015Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000241a.wal"} {"level":"warn","ts":"2026-05-21T00:41:37.905105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.234153ms","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-05-21T00:41:37.905228Z","caller":"traceutil/trace.go:171","msg":"trace[1313991146] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9422; }","duration":"109.440468ms","start":"2026-05-21T00:41:37.795763Z","end":"2026-05-21T00:41:37.905204Z","steps":["trace[1313991146] 'range keys from in-memory index tree' (duration: 108.918236ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:41:37.905258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.759086ms","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-21T00:41:37.905383Z","caller":"traceutil/trace.go:171","msg":"trace[1485887174] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9422; }","duration":"124.948881ms","start":"2026-05-21T00:41:37.780405Z","end":"2026-05-21T00:41:37.905354Z","steps":["trace[1485887174] 'range keys from in-memory index tree' (duration: 124.46341ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:41:37.905493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.619169ms","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-05-21T00:41:37.905613Z","caller":"traceutil/trace.go:171","msg":"trace[1984479853] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9422; }","duration":"213.884365ms","start":"2026-05-21T00:41:37.691702Z","end":"2026-05-21T00:41:37.905586Z","steps":["trace[1984479853] 'range keys from in-memory index tree' (duration: 213.390953ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:41:38.100101Z","caller":"traceutil/trace.go:171","msg":"trace[1493721522] transaction","detail":"{read_only:false; response_revision:9426; number_of_response:1; }","duration":"117.085063ms","start":"2026-05-21T00:41:37.982989Z","end":"2026-05-21T00:41:38.100074Z","steps":["trace[1493721522] 'process raft request' (duration: 116.919349ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:42:11.164174Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"3ba9ae53cc4335db","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-21T00:42:11.169598Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-05-21T00:42:11.16973Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-05-21T00:44:26.669734Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8287} {"level":"info","ts":"2026-05-21T00:44:26.750612Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8287,"took":"78.106133ms","hash":3468855657,"current-db-size-bytes":57913344,"current-db-size":"58 MB","current-db-size-in-use-bytes":25202688,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-05-21T00:44:26.750694Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3468855657,"revision":8287,"compact-revision":6065}