{"level":"warn","ts":"2026-04-23T00:12:01.03384Z","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-23T00:12:01.03398Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.153: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.153:2380","--initial-cluster=instance=https://199.204.45.153:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.153:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.153: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-23T00:12:01.034079Z","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-23T00:12:01.034097Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.153:2380"]} {"level":"info","ts":"2026-04-23T00:12:01.034126Z","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-23T00:12:01.035025Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"]} {"level":"info","ts":"2026-04-23T00:12:01.035137Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.153: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-23T00:12:01.03979Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.323691ms"} {"level":"info","ts":"2026-04-23T00:12:01.046723Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"355195d5aae85944","cluster-id":"e424441517bc0b32"} {"level":"info","ts":"2026-04-23T00:12:01.046817Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=()"} {"level":"info","ts":"2026-04-23T00:12:01.046842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 0"} {"level":"info","ts":"2026-04-23T00:12:01.04686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 355195d5aae85944 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-23T00:12:01.046868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 1"} {"level":"info","ts":"2026-04-23T00:12:01.046917Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"} {"level":"warn","ts":"2026-04-23T00:12:01.054984Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-23T00:12:01.056745Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-23T00:12:01.058366Z","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-23T00:12:01.060881Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"355195d5aae85944","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-23T00:12:01.061983Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"355195d5aae85944","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-23T00:12:01.062277Z","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-23T00:12:01.062348Z","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-23T00:12:01.06235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"} {"level":"info","ts":"2026-04-23T00:12:01.062361Z","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-23T00:12:01.067096Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","added-peer-id":"355195d5aae85944","added-peer-peer-urls":["https://199.204.45.153:2380"]} {"level":"info","ts":"2026-04-23T00:12:01.070781Z","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-23T00:12:01.071029Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"355195d5aae85944","initial-advertise-peer-urls":["https://199.204.45.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-23T00:12:01.071067Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-23T00:12:01.071191Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.153:2380"} {"level":"info","ts":"2026-04-23T00:12:01.071213Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.153:2380"} {"level":"info","ts":"2026-04-23T00:12:01.547186Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 is starting a new election at term 1"} {"level":"info","ts":"2026-04-23T00:12:01.547379Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-23T00:12:01.547489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgPreVoteResp from 355195d5aae85944 at term 1"} {"level":"info","ts":"2026-04-23T00:12:01.54759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became candidate at term 2"} {"level":"info","ts":"2026-04-23T00:12:01.547631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgVoteResp from 355195d5aae85944 at term 2"} {"level":"info","ts":"2026-04-23T00:12:01.547685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became leader at term 2"} {"level":"info","ts":"2026-04-23T00:12:01.547744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 355195d5aae85944 elected leader 355195d5aae85944 at term 2"} {"level":"info","ts":"2026-04-23T00:12:01.548971Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T00:12:01.549646Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"355195d5aae85944","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.153:2379]}","request-path":"/0/members/355195d5aae85944/attributes","cluster-id":"e424441517bc0b32","publish-timeout":"7s"} {"level":"info","ts":"2026-04-23T00:12:01.549865Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T00:12:01.549964Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T00:12:01.550187Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-23T00:12:01.550266Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-23T00:12:01.550303Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T00:12:01.550481Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T00:12:01.550524Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T00:12:01.553461Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-23T00:12:01.553677Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.153:2379"} {"level":"warn","ts":"2026-04-23T00:12:12.223823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.999937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-23T00:12:12.223947Z","caller":"traceutil/trace.go:171","msg":"trace[294952012] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:346; }","duration":"191.1844ms","start":"2026-04-23T00:12:12.032735Z","end":"2026-04-23T00:12:12.22392Z","steps":["trace[294952012] 'range keys from in-memory index tree' (duration: 190.870085ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:12:12.224158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.158293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-04-23T00:12:12.224303Z","caller":"traceutil/trace.go:171","msg":"trace[320466894] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:346; }","duration":"242.001055ms","start":"2026-04-23T00:12:11.982247Z","end":"2026-04-23T00:12:12.224248Z","steps":["trace[320466894] 'range keys from in-memory index tree' (duration: 241.017211ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:12:12.224676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.405029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-23T00:12:12.224813Z","caller":"traceutil/trace.go:171","msg":"trace[162646267] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:346; }","duration":"141.577521ms","start":"2026-04-23T00:12:12.083216Z","end":"2026-04-23T00:12:12.224794Z","steps":["trace[162646267] 'range keys from in-memory index tree' (duration: 141.295968ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:12:12.369414Z","caller":"traceutil/trace.go:171","msg":"trace[399432925] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"140.600268ms","start":"2026-04-23T00:12:12.228792Z","end":"2026-04-23T00:12:12.369393Z","steps":["trace[399432925] 'process raft request' (duration: 140.470936ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:12:12.631501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.073994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-23T00:12:12.631611Z","caller":"traceutil/trace.go:171","msg":"trace[1425057894] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:350; }","duration":"399.328678ms","start":"2026-04-23T00:12:12.232263Z","end":"2026-04-23T00:12:12.631591Z","steps":["trace[1425057894] 'agreement among raft nodes before linearized reading' (duration: 397.879098ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:12:12.631673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:12:12.232247Z","time spent":"399.412969ms","remote":"127.0.0.1:53150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"info","ts":"2026-04-23T00:12:12.629466Z","caller":"traceutil/trace.go:171","msg":"trace[933664237] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"397.237469ms","start":"2026-04-23T00:12:12.232199Z","end":"2026-04-23T00:12:12.629437Z","steps":["trace[933664237] 'process raft request' (duration: 391.904824ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:12:12.63212Z","caller":"traceutil/trace.go:171","msg":"trace[1600012563] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"397.824048ms","start":"2026-04-23T00:12:12.234246Z","end":"2026-04-23T00:12:12.63207Z","steps":["trace[1600012563] 'process raft request' (duration: 395.031368ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:12:12.632321Z","caller":"traceutil/trace.go:171","msg":"trace[281443022] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"397.766216ms","start":"2026-04-23T00:12:12.234263Z","end":"2026-04-23T00:12:12.632029Z","steps":["trace[281443022] 'process raft request' (duration: 395.645566ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:12:12.630104Z","caller":"traceutil/trace.go:171","msg":"trace[343801145] linearizableReadLoop","detail":"{readStateIndex:364; appliedIndex:362; }","duration":"397.755326ms","start":"2026-04-23T00:12:12.232298Z","end":"2026-04-23T00:12:12.630054Z","steps":["trace[343801145] 'read index received' (duration: 137.007967ms)","trace[343801145] 'applied index is now lower than readState.Index' (duration: 260.745629ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:12:12.633224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.645803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-04-23T00:12:12.633275Z","caller":"traceutil/trace.go:171","msg":"trace[998264855] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:350; }","duration":"350.943847ms","start":"2026-04-23T00:12:12.282315Z","end":"2026-04-23T00:12:12.633259Z","steps":["trace[998264855] 'agreement among raft nodes before linearized reading' (duration: 350.772545ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:12:12.63351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:12:12.282302Z","time spent":"351.19692ms","remote":"127.0.0.1:53150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":218,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"warn","ts":"2026-04-23T00:12:12.634041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.923663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T00:12:12.634195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.91939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-04-23T00:12:12.634246Z","caller":"traceutil/trace.go:171","msg":"trace[1498413024] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:350; }","duration":"250.996691ms","start":"2026-04-23T00:12:12.383229Z","end":"2026-04-23T00:12:12.634226Z","steps":["trace[1498413024] 'agreement among raft nodes before linearized reading' (duration: 250.696247ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:12:12.634296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:12:12.23218Z","time spent":"399.888547ms","remote":"127.0.0.1:53238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1050,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T00:12:12.634353Z","caller":"traceutil/trace.go:171","msg":"trace[685262073] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:350; }","duration":"241.986574ms","start":"2026-04-23T00:12:12.392086Z","end":"2026-04-23T00:12:12.634073Z","steps":["trace[685262073] 'agreement among raft nodes before linearized reading' (duration: 241.607559ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:12:12.634449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.958963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-23T00:12:12.634567Z","caller":"traceutil/trace.go:171","msg":"trace[515036077] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:350; }","duration":"151.045104ms","start":"2026-04-23T00:12:12.483478Z","end":"2026-04-23T00:12:12.634523Z","steps":["trace[515036077] 'agreement among raft nodes before linearized reading' (duration: 150.679869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:12:12.634629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:12:12.234232Z","time spent":"397.964679ms","remote":"127.0.0.1:53046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1723,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T00:12:12.634689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.686334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-04-23T00:12:12.634822Z","caller":"traceutil/trace.go:171","msg":"trace[86486796] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:350; }","duration":"301.913208ms","start":"2026-04-23T00:12:12.332888Z","end":"2026-04-23T00:12:12.634802Z","steps":["trace[86486796] 'agreement among raft nodes before linearized reading' (duration: 301.636693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:12:12.634873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:12:12.33287Z","time spent":"301.985969ms","remote":"127.0.0.1:53150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":241,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "} {"level":"warn","ts":"2026-04-23T00:12:12.633745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.772171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-04-23T00:12:12.635037Z","caller":"traceutil/trace.go:171","msg":"trace[234039570] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:350; }","duration":"201.18066ms","start":"2026-04-23T00:12:12.433835Z","end":"2026-04-23T00:12:12.635015Z","steps":["trace[234039570] 'agreement among raft nodes before linearized reading' (duration: 199.569277ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:12:12.63509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:12:12.234243Z","time spent":"398.178442ms","remote":"127.0.0.1:53428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3642,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T00:12:39.186301Z","caller":"traceutil/trace.go:171","msg":"trace[1668178885] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"276.231097ms","start":"2026-04-23T00:12:38.910047Z","end":"2026-04-23T00:12:39.186278Z","steps":["trace[1668178885] 'process raft request' (duration: 275.761534ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:12:39.391664Z","caller":"traceutil/trace.go:171","msg":"trace[876104315] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"152.087279ms","start":"2026-04-23T00:12:39.23955Z","end":"2026-04-23T00:12:39.391637Z","steps":["trace[876104315] 'process raft request' (duration: 151.910634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:12:39.818248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.981394ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T00:12:39.818415Z","caller":"traceutil/trace.go:171","msg":"trace[1605296041] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:644; }","duration":"194.197778ms","start":"2026-04-23T00:12:39.624205Z","end":"2026-04-23T00:12:39.818402Z","steps":["trace[1605296041] 'read index received' (duration: 97.622043ms)","trace[1605296041] 'applied index is now lower than readState.Index' (duration: 96.574865ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:12:39.818478Z","caller":"traceutil/trace.go:171","msg":"trace[417865875] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"380.160499ms","start":"2026-04-23T00:12:39.438292Z","end":"2026-04-23T00:12:39.818452Z","steps":["trace[417865875] 'process raft request' (duration: 380.065627ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:12:39.818468Z","caller":"traceutil/trace.go:171","msg":"trace[635204319] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"382.330707ms","start":"2026-04-23T00:12:39.436098Z","end":"2026-04-23T00:12:39.818429Z","steps":["trace[635204319] 'process raft request' (duration: 86.906361ms)","trace[635204319] 'compare' (duration: 294.879422ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:12:39.818528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.329161ms","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-23T00:12:39.818553Z","caller":"traceutil/trace.go:171","msg":"trace[1686574446] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:622; }","duration":"194.401753ms","start":"2026-04-23T00:12:39.624145Z","end":"2026-04-23T00:12:39.818547Z","steps":["trace[1686574446] 'agreement among raft nodes before linearized reading' (duration: 194.29732ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:12:39.818601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:12:39.438281Z","time spent":"380.255572ms","remote":"127.0.0.1:53222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T00:12:39.81865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:12:39.436088Z","time spent":"382.47068ms","remote":"127.0.0.1:53222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T00:12:55.032412Z","caller":"traceutil/trace.go:171","msg":"trace[1342085230] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"239.815346ms","start":"2026-04-23T00:12:54.79257Z","end":"2026-04-23T00:12:55.032385Z","steps":["trace[1342085230] 'process raft request' (duration: 239.622261ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:14:16.52276Z","caller":"traceutil/trace.go:171","msg":"trace[678226725] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"349.315873ms","start":"2026-04-23T00:14:16.173419Z","end":"2026-04-23T00:14:16.522735Z","steps":["trace[678226725] 'process raft request' (duration: 349.16474ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:14:16.522916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:14:16.173405Z","time spent":"349.433545ms","remote":"127.0.0.1:53126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T00:14:16.558728Z","caller":"traceutil/trace.go:171","msg":"trace[1602525829] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"294.892011ms","start":"2026-04-23T00:14:16.2638Z","end":"2026-04-23T00:14:16.558692Z","steps":["trace[1602525829] 'process raft request' (duration: 294.830829ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:14:16.558969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.611158ms","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-23T00:14:16.559018Z","caller":"traceutil/trace.go:171","msg":"trace[1343407747] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1871; }","duration":"332.694629ms","start":"2026-04-23T00:14:16.226311Z","end":"2026-04-23T00:14:16.559005Z","steps":["trace[1343407747] 'agreement among raft nodes before linearized reading' (duration: 332.555467ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:14:16.559052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:14:16.226299Z","time spent":"332.74148ms","remote":"127.0.0.1:37538","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-23T00:14:16.559225Z","caller":"traceutil/trace.go:171","msg":"trace[1740826165] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"171.535042ms","start":"2026-04-23T00:14:16.38768Z","end":"2026-04-23T00:14:16.559215Z","steps":["trace[1740826165] 'process raft request' (duration: 170.991671ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:14:16.558829Z","caller":"traceutil/trace.go:171","msg":"trace[2005506506] linearizableReadLoop","detail":"{readStateIndex:1944; appliedIndex:1942; }","duration":"332.458785ms","start":"2026-04-23T00:14:16.226352Z","end":"2026-04-23T00:14:16.55881Z","steps":["trace[2005506506] 'read index received' (duration: 296.202884ms)","trace[2005506506] 'applied index is now lower than readState.Index' (duration: 36.255091ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:14:16.559393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.161814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:14:16.559455Z","caller":"traceutil/trace.go:171","msg":"trace[207790054] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1871; }","duration":"167.247635ms","start":"2026-04-23T00:14:16.39219Z","end":"2026-04-23T00:14:16.559437Z","steps":["trace[207790054] 'agreement among raft nodes before linearized reading' (duration: 167.123533ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:14:16.559573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.26734ms","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-23T00:14:16.559613Z","caller":"traceutil/trace.go:171","msg":"trace[762739390] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1871; }","duration":"144.342701ms","start":"2026-04-23T00:14:16.415262Z","end":"2026-04-23T00:14:16.559604Z","steps":["trace[762739390] 'agreement among raft nodes before linearized reading' (duration: 144.236529ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:14:16.559776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.258408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-23T00:14:16.559829Z","caller":"traceutil/trace.go:171","msg":"trace[530823403] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1871; }","duration":"153.3346ms","start":"2026-04-23T00:14:16.406482Z","end":"2026-04-23T00:14:16.559817Z","steps":["trace[530823403] 'agreement among raft nodes before linearized reading' (duration: 153.137287ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:14:16.559979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.550131ms","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-04-23T00:14:16.560098Z","caller":"traceutil/trace.go:171","msg":"trace[1010848793] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1871; }","duration":"167.681724ms","start":"2026-04-23T00:14:16.392399Z","end":"2026-04-23T00:14:16.56008Z","steps":["trace[1010848793] 'agreement among raft nodes before linearized reading' (duration: 167.404969ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:14:16.559149Z","caller":"traceutil/trace.go:171","msg":"trace[618782723] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"382.239375ms","start":"2026-04-23T00:14:16.176748Z","end":"2026-04-23T00:14:16.558987Z","steps":["trace[618782723] 'process raft request' (duration: 363.775948ms)","trace[618782723] 'compare' (duration: 17.986317ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:14:16.560377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:14:16.176732Z","time spent":"383.552478ms","remote":"127.0.0.1:53222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T00:14:16.868978Z","caller":"traceutil/trace.go:171","msg":"trace[381936977] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"303.703846ms","start":"2026-04-23T00:14:16.565248Z","end":"2026-04-23T00:14:16.868952Z","steps":["trace[381936977] 'process raft request' (duration: 303.456522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:14:16.869126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:14:16.565223Z","time spent":"303.829179ms","remote":"127.0.0.1:53222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T00:14:16.869234Z","caller":"traceutil/trace.go:171","msg":"trace[1637606988] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"298.272649ms","start":"2026-04-23T00:14:16.570935Z","end":"2026-04-23T00:14:16.869208Z","steps":["trace[1637606988] 'process raft request' (duration: 298.195418ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:14:16.869429Z","caller":"traceutil/trace.go:171","msg":"trace[1945049093] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"303.679256ms","start":"2026-04-23T00:14:16.565661Z","end":"2026-04-23T00:14:16.86934Z","steps":["trace[1945049093] 'process raft request' (duration: 303.253238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:14:16.869764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:14:16.565651Z","time spent":"303.91817ms","remote":"127.0.0.1:53222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T00:14:16.965529Z","caller":"traceutil/trace.go:171","msg":"trace[1815269087] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"164.271423ms","start":"2026-04-23T00:14:16.801233Z","end":"2026-04-23T00:14:16.965504Z","steps":["trace[1815269087] 'process raft request' (duration: 163.706652ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:14:16.975779Z","caller":"traceutil/trace.go:171","msg":"trace[349902772] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"100.088808ms","start":"2026-04-23T00:14:16.875659Z","end":"2026-04-23T00:14:16.975748Z","steps":["trace[349902772] 'process raft request' (duration: 99.863844ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:14:28.814368Z","caller":"traceutil/trace.go:171","msg":"trace[1640578091] transaction","detail":"{read_only:false; response_revision:1974; number_of_response:1; }","duration":"211.038702ms","start":"2026-04-23T00:14:28.603304Z","end":"2026-04-23T00:14:28.814343Z","steps":["trace[1640578091] 'process raft request' (duration: 210.881939ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:14:28.827791Z","caller":"traceutil/trace.go:171","msg":"trace[1289720614] transaction","detail":"{read_only:false; response_revision:1975; number_of_response:1; }","duration":"214.485541ms","start":"2026-04-23T00:14:28.613282Z","end":"2026-04-23T00:14:28.827768Z","steps":["trace[1289720614] 'process raft request' (duration: 214.268587ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:14:28.827888Z","caller":"traceutil/trace.go:171","msg":"trace[702756094] linearizableReadLoop","detail":"{readStateIndex:2054; appliedIndex:2051; }","duration":"179.740351ms","start":"2026-04-23T00:14:28.648125Z","end":"2026-04-23T00:14:28.827866Z","steps":["trace[702756094] 'read index received' (duration: 166.023145ms)","trace[702756094] 'applied index is now lower than readState.Index' (duration: 13.715216ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:14:28.82797Z","caller":"traceutil/trace.go:171","msg":"trace[263948420] transaction","detail":"{read_only:false; response_revision:1976; number_of_response:1; }","duration":"214.164865ms","start":"2026-04-23T00:14:28.61379Z","end":"2026-04-23T00:14:28.827955Z","steps":["trace[263948420] 'process raft request' (duration: 213.89836ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:14:28.828204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.197116ms","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-04-23T00:14:28.828352Z","caller":"traceutil/trace.go:171","msg":"trace[2036140939] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1976; }","duration":"174.386219ms","start":"2026-04-23T00:14:28.653948Z","end":"2026-04-23T00:14:28.828334Z","steps":["trace[2036140939] 'agreement among raft nodes before linearized reading' (duration: 174.063234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:14:28.828694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.563315ms","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-23T00:14:28.829588Z","caller":"traceutil/trace.go:171","msg":"trace[319143025] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1976; }","duration":"181.486612ms","start":"2026-04-23T00:14:28.648079Z","end":"2026-04-23T00:14:28.829565Z","steps":["trace[319143025] 'agreement among raft nodes before linearized reading' (duration: 179.940795ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:14:55.075257Z","caller":"traceutil/trace.go:171","msg":"trace[1308282076] linearizableReadLoop","detail":"{readStateIndex:2218; appliedIndex:2216; }","duration":"125.577992ms","start":"2026-04-23T00:14:54.949652Z","end":"2026-04-23T00:14:55.07523Z","steps":["trace[1308282076] 'read index received' (duration: 94.445276ms)","trace[1308282076] 'applied index is now lower than readState.Index' (duration: 31.131345ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:14:55.075408Z","caller":"traceutil/trace.go:171","msg":"trace[214867032] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"136.093436ms","start":"2026-04-23T00:14:54.939302Z","end":"2026-04-23T00:14:55.075395Z","steps":["trace[214867032] 'process raft request' (duration: 104.820998ms)","trace[214867032] 'compare' (duration: 30.892122ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:14:55.075816Z","caller":"traceutil/trace.go:171","msg":"trace[7736560] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"131.670532ms","start":"2026-04-23T00:14:54.944134Z","end":"2026-04-23T00:14:55.075805Z","steps":["trace[7736560] 'process raft request' (duration: 131.034962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:14:55.076132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.460786ms","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-04-23T00:14:55.076174Z","caller":"traceutil/trace.go:171","msg":"trace[1706821351] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2134; }","duration":"126.543787ms","start":"2026-04-23T00:14:54.94962Z","end":"2026-04-23T00:14:55.076164Z","steps":["trace[1706821351] 'agreement among raft nodes before linearized reading' (duration: 126.355454ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:14:55.96946Z","caller":"traceutil/trace.go:171","msg":"trace[143322117] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"120.197701ms","start":"2026-04-23T00:14:55.849209Z","end":"2026-04-23T00:14:55.969406Z","steps":["trace[143322117] 'process raft request' (duration: 119.691302ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:14:56.188195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.41174ms","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-23T00:14:56.188398Z","caller":"traceutil/trace.go:171","msg":"trace[1652033084] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2140; }","duration":"103.665725ms","start":"2026-04-23T00:14:56.084705Z","end":"2026-04-23T00:14:56.188371Z","steps":["trace[1652033084] 'range keys from in-memory index tree' (duration: 103.190337ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:15:56.415441Z","caller":"traceutil/trace.go:171","msg":"trace[171866221] transaction","detail":"{read_only:false; response_revision:2570; number_of_response:1; }","duration":"116.770269ms","start":"2026-04-23T00:15:56.298631Z","end":"2026-04-23T00:15:56.415401Z","steps":["trace[171866221] 'process raft request' (duration: 116.057108ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:16:33.595228Z","caller":"traceutil/trace.go:171","msg":"trace[454579229] transaction","detail":"{read_only:false; response_revision:2773; number_of_response:1; }","duration":"110.71586ms","start":"2026-04-23T00:16:33.484481Z","end":"2026-04-23T00:16:33.595197Z","steps":["trace[454579229] 'process raft request' (duration: 110.483717ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:16:33.787861Z","caller":"traceutil/trace.go:171","msg":"trace[1881071277] transaction","detail":"{read_only:false; response_revision:2774; number_of_response:1; }","duration":"188.053782ms","start":"2026-04-23T00:16:33.599778Z","end":"2026-04-23T00:16:33.787831Z","steps":["trace[1881071277] 'process raft request' (duration: 187.821159ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:16:33.792799Z","caller":"traceutil/trace.go:171","msg":"trace[65083545] transaction","detail":"{read_only:false; response_revision:2775; number_of_response:1; }","duration":"190.692973ms","start":"2026-04-23T00:16:33.602088Z","end":"2026-04-23T00:16:33.792781Z","steps":["trace[65083545] 'process raft request' (duration: 190.373879ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:16:33.792707Z","caller":"traceutil/trace.go:171","msg":"trace[222795127] transaction","detail":"{read_only:false; response_revision:2776; number_of_response:1; }","duration":"190.143805ms","start":"2026-04-23T00:16:33.602528Z","end":"2026-04-23T00:16:33.792672Z","steps":["trace[222795127] 'process raft request' (duration: 190.084644ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:20:15.108411Z","caller":"traceutil/trace.go:171","msg":"trace[1371948985] transaction","detail":"{read_only:false; response_revision:4568; number_of_response:1; }","duration":"107.752607ms","start":"2026-04-23T00:20:15.000625Z","end":"2026-04-23T00:20:15.108378Z","steps":["trace[1371948985] 'process raft request' (duration: 101.852004ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:20:22.347164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.059529ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-23T00:20:22.347872Z","caller":"traceutil/trace.go:171","msg":"trace[1878600134] transaction","detail":"{read_only:false; response_revision:4743; number_of_response:1; }","duration":"145.939565ms","start":"2026-04-23T00:20:22.201886Z","end":"2026-04-23T00:20:22.347826Z","steps":["trace[1878600134] 'process raft request' (duration: 44.146283ms)","trace[1878600134] 'compare' (duration: 100.931135ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:20:22.613154Z","caller":"traceutil/trace.go:171","msg":"trace[1555305010] linearizableReadLoop","detail":"{readStateIndex:4927; appliedIndex:4926; }","duration":"213.817106ms","start":"2026-04-23T00:20:22.39931Z","end":"2026-04-23T00:20:22.613127Z","steps":["trace[1555305010] 'read index received' (duration: 134.831935ms)","trace[1555305010] 'applied index is now lower than readState.Index' (duration: 78.983941ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:20:22.613185Z","caller":"traceutil/trace.go:171","msg":"trace[1252187600] transaction","detail":"{read_only:false; response_revision:4744; number_of_response:1; }","duration":"216.62745ms","start":"2026-04-23T00:20:22.396528Z","end":"2026-04-23T00:20:22.613155Z","steps":["trace[1252187600] 'process raft request' (duration: 137.521546ms)","trace[1252187600] 'compare' (duration: 78.827818ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:20:22.613551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.198304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-04-23T00:20:22.613599Z","caller":"traceutil/trace.go:171","msg":"trace[1325230675] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4744; }","duration":"214.311757ms","start":"2026-04-23T00:20:22.399275Z","end":"2026-04-23T00:20:22.613587Z","steps":["trace[1325230675] 'agreement among raft nodes before linearized reading' (duration: 213.95691ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:20:22.638472Z","caller":"traceutil/trace.go:171","msg":"trace[1541198406] transaction","detail":"{read_only:false; response_revision:4745; number_of_response:1; }","duration":"228.625316ms","start":"2026-04-23T00:20:22.409821Z","end":"2026-04-23T00:20:22.638446Z","steps":["trace[1541198406] 'process raft request' (duration: 228.453322ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:20:22.638739Z","caller":"traceutil/trace.go:171","msg":"trace[776313924] transaction","detail":"{read_only:false; response_revision:4746; number_of_response:1; }","duration":"220.799318ms","start":"2026-04-23T00:20:22.41792Z","end":"2026-04-23T00:20:22.638719Z","steps":["trace[776313924] 'process raft request' (duration: 220.484141ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:20:35.518891Z","caller":"traceutil/trace.go:171","msg":"trace[1924655669] transaction","detail":"{read_only:false; response_revision:4938; number_of_response:1; }","duration":"210.110524ms","start":"2026-04-23T00:20:35.308744Z","end":"2026-04-23T00:20:35.518854Z","steps":["trace[1924655669] 'process raft request' (duration: 209.842549ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:20:35.553322Z","caller":"traceutil/trace.go:171","msg":"trace[1835657525] linearizableReadLoop","detail":"{readStateIndex:5129; appliedIndex:5127; }","duration":"159.425578ms","start":"2026-04-23T00:20:35.393865Z","end":"2026-04-23T00:20:35.55329Z","steps":["trace[1835657525] 'read index received' (duration: 124.942853ms)","trace[1835657525] 'applied index is now lower than readState.Index' (duration: 34.481615ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:20:35.553486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.606811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:20:35.553528Z","caller":"traceutil/trace.go:171","msg":"trace[1799194964] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4939; }","duration":"159.702753ms","start":"2026-04-23T00:20:35.393812Z","end":"2026-04-23T00:20:35.553515Z","steps":["trace[1799194964] 'agreement among raft nodes before linearized reading' (duration: 159.591101ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:20:35.55365Z","caller":"traceutil/trace.go:171","msg":"trace[1760119621] transaction","detail":"{read_only:false; response_revision:4939; number_of_response:1; }","duration":"243.784413ms","start":"2026-04-23T00:20:35.309621Z","end":"2026-04-23T00:20:35.553406Z","steps":["trace[1760119621] 'process raft request' (duration: 243.510568ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:21:07.493327Z","caller":"traceutil/trace.go:171","msg":"trace[1919969740] linearizableReadLoop","detail":"{readStateIndex:5419; appliedIndex:5418; }","duration":"100.699049ms","start":"2026-04-23T00:21:07.392601Z","end":"2026-04-23T00:21:07.4933Z","steps":["trace[1919969740] 'read index received' (duration: 54.906803ms)","trace[1919969740] 'applied index is now lower than readState.Index' (duration: 45.790686ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:21:07.493379Z","caller":"traceutil/trace.go:171","msg":"trace[1465928646] transaction","detail":"{read_only:false; response_revision:5222; number_of_response:1; }","duration":"136.640324ms","start":"2026-04-23T00:21:07.356706Z","end":"2026-04-23T00:21:07.493346Z","steps":["trace[1465928646] 'process raft request' (duration: 90.825548ms)","trace[1465928646] 'compare' (duration: 45.625532ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:21:07.493527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.913783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:21:07.493562Z","caller":"traceutil/trace.go:171","msg":"trace[1487965523] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5222; }","duration":"100.987413ms","start":"2026-04-23T00:21:07.392566Z","end":"2026-04-23T00:21:07.493553Z","steps":["trace[1487965523] 'agreement among raft nodes before linearized reading' (duration: 100.847281ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:22:01.577577Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2918} {"level":"info","ts":"2026-04-23T00:22:01.674655Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2918,"took":"95.746909ms","hash":1270456650,"current-db-size-bytes":54550528,"current-db-size":"55 MB","current-db-size-in-use-bytes":29573120,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-23T00:22:01.674723Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1270456650,"revision":2918,"compact-revision":-1} {"level":"warn","ts":"2026-04-23T00:24:20.210012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.393053ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-23T00:27:01.585379Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5638} {"level":"info","ts":"2026-04-23T00:27:01.662095Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5638,"took":"75.69793ms","hash":555459544,"current-db-size-bytes":54550528,"current-db-size":"55 MB","current-db-size-in-use-bytes":18399232,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-23T00:27:01.662135Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":555459544,"revision":5638,"compact-revision":2918}