{"level":"warn","ts":"2026-04-08T10:41:50.602369Z","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-08T10:41:50.602449Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.181:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.181:2380","--initial-cluster=instance=https://199.19.213.181:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.181:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.181: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-08T10:41:50.602512Z","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-08T10:41:50.602524Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.181:2380"]} {"level":"info","ts":"2026-04-08T10:41:50.602539Z","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-08T10:41:50.603136Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.181:2379"]} {"level":"info","ts":"2026-04-08T10:41:50.603281Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.181:2380"],"listen-peer-urls":["https://199.19.213.181:2380"],"advertise-client-urls":["https://199.19.213.181:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.181:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.181: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-08T10:41:50.610992Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.786378ms"} {"level":"info","ts":"2026-04-08T10:41:50.620818Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1a532052a1358225","cluster-id":"b34324311008a1d3"} {"level":"info","ts":"2026-04-08T10:41:50.620894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T10:41:50.620919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 became follower at term 0"} {"level":"info","ts":"2026-04-08T10:41:50.620935Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1a532052a1358225 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T10:41:50.620949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 became follower at term 1"} {"level":"info","ts":"2026-04-08T10:41:50.621048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 switched to configuration voters=(1896895407317156389)"} {"level":"warn","ts":"2026-04-08T10:41:50.628587Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T10:41:50.631013Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T10:41:50.632334Z","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-08T10:41:50.636577Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1a532052a1358225","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T10:41:50.636761Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1a532052a1358225","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T10:41:50.636912Z","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-08T10:41:50.637048Z","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-08T10:41:50.637074Z","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-08T10:41:50.639264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 switched to configuration voters=(1896895407317156389)"} {"level":"info","ts":"2026-04-08T10:41:50.639928Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b34324311008a1d3","local-member-id":"1a532052a1358225","added-peer-id":"1a532052a1358225","added-peer-peer-urls":["https://199.19.213.181:2380"]} {"level":"info","ts":"2026-04-08T10:41:50.641679Z","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-08T10:41:50.641964Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.181:2380"} {"level":"info","ts":"2026-04-08T10:41:50.642027Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.181:2380"} {"level":"info","ts":"2026-04-08T10:41:50.642246Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1a532052a1358225","initial-advertise-peer-urls":["https://199.19.213.181:2380"],"listen-peer-urls":["https://199.19.213.181:2380"],"advertise-client-urls":["https://199.19.213.181:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.181:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T10:41:50.642286Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T10:41:51.221608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T10:41:51.221721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T10:41:51.221765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 received MsgPreVoteResp from 1a532052a1358225 at term 1"} {"level":"info","ts":"2026-04-08T10:41:51.221793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 became candidate at term 2"} {"level":"info","ts":"2026-04-08T10:41:51.221812Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 received MsgVoteResp from 1a532052a1358225 at term 2"} {"level":"info","ts":"2026-04-08T10:41:51.221838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 became leader at term 2"} {"level":"info","ts":"2026-04-08T10:41:51.221863Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1a532052a1358225 elected leader 1a532052a1358225 at term 2"} {"level":"info","ts":"2026-04-08T10:41:51.22305Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T10:41:51.223833Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1a532052a1358225","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.181:2379]}","request-path":"/0/members/1a532052a1358225/attributes","cluster-id":"b34324311008a1d3","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T10:41:51.224122Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T10:41:51.224232Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T10:41:51.224329Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T10:41:51.224371Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T10:41:51.22426Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b34324311008a1d3","local-member-id":"1a532052a1358225","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T10:41:51.224512Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T10:41:51.224581Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T10:41:51.227411Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T10:41:51.227784Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.181:2379"} {"level":"warn","ts":"2026-04-08T10:41:54.470231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.655039ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T10:41:54.470384Z","caller":"traceutil/trace.go:171","msg":"trace[154266466] transaction","detail":"{read_only:false; response_revision:159; number_of_response:1; }","duration":"426.389491ms","start":"2026-04-08T10:41:54.043972Z","end":"2026-04-08T10:41:54.470361Z","steps":["trace[154266466] 'process raft request' (duration: 120.699627ms)","trace[154266466] 'compare' (duration: 304.472743ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:41:54.470476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:41:54.043963Z","time spent":"426.481613ms","remote":"127.0.0.1:40152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":760,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T10:41:55.567596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"791.297506ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T10:41:55.56772Z","caller":"traceutil/trace.go:171","msg":"trace[1058702187] linearizableReadLoop","detail":"{readStateIndex:164; appliedIndex:163; }","duration":"913.73006ms","start":"2026-04-08T10:41:54.653972Z","end":"2026-04-08T10:41:55.567702Z","steps":["trace[1058702187] 'read index received' (duration: 122.203957ms)","trace[1058702187] 'applied index is now lower than readState.Index' (duration: 791.525093ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:41:55.567787Z","caller":"traceutil/trace.go:171","msg":"trace[1743054778] transaction","detail":"{read_only:false; response_revision:160; number_of_response:1; }","duration":"1.091714603s","start":"2026-04-08T10:41:54.476034Z","end":"2026-04-08T10:41:55.567749Z","steps":["trace[1743054778] 'process raft request' (duration: 300.19523ms)","trace[1743054778] 'compare' (duration: 791.169961ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:41:55.568016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"913.948597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T10:41:55.568021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:41:54.476008Z","time spent":"1.091899589s","remote":"127.0.0.1:40152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":760,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T10:41:55.568067Z","caller":"traceutil/trace.go:171","msg":"trace[408024066] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:160; }","duration":"914.121453ms","start":"2026-04-08T10:41:54.653931Z","end":"2026-04-08T10:41:55.568053Z","steps":["trace[408024066] 'agreement among raft nodes before linearized reading' (duration: 913.855744ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:41:55.568045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.924004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T10:41:55.568109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:41:54.653913Z","time spent":"914.186415ms","remote":"127.0.0.1:39808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-08T10:41:55.568182Z","caller":"traceutil/trace.go:171","msg":"trace[454372558] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:160; }","duration":"376.202972ms","start":"2026-04-08T10:41:55.191932Z","end":"2026-04-08T10:41:55.568135Z","steps":["trace[454372558] 'agreement among raft nodes before linearized reading' (duration: 375.927223ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:41:55.568264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:41:55.191913Z","time spent":"376.337617ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-08T10:41:55.696259Z","caller":"traceutil/trace.go:171","msg":"trace[526144889] linearizableReadLoop","detail":"{readStateIndex:165; appliedIndex:164; }","duration":"123.838217ms","start":"2026-04-08T10:41:55.572397Z","end":"2026-04-08T10:41:55.696235Z","steps":["trace[526144889] 'read index received' (duration: 107.746014ms)","trace[526144889] 'applied index is now lower than readState.Index' (duration: 16.091313ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:41:55.696393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.975931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:job-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T10:41:55.696417Z","caller":"traceutil/trace.go:171","msg":"trace[1343819579] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:job-controller; range_end:; response_count:0; response_revision:161; }","duration":"124.050244ms","start":"2026-04-08T10:41:55.572358Z","end":"2026-04-08T10:41:55.696408Z","steps":["trace[1343819579] 'agreement among raft nodes before linearized reading' (duration: 123.971541ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:41:55.69669Z","caller":"traceutil/trace.go:171","msg":"trace[732070230] transaction","detail":"{read_only:false; response_revision:161; number_of_response:1; }","duration":"124.87689ms","start":"2026-04-08T10:41:55.571796Z","end":"2026-04-08T10:41:55.696673Z","steps":["trace[732070230] 'process raft request' (duration: 108.418735ms)","trace[732070230] 'compare' (duration: 15.874255ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:41:56.877228Z","caller":"traceutil/trace.go:171","msg":"trace[1899785002] linearizableReadLoop","detail":"{readStateIndex:224; appliedIndex:223; }","duration":"106.39161ms","start":"2026-04-08T10:41:56.770803Z","end":"2026-04-08T10:41:56.877195Z","steps":["trace[1899785002] 'read index received' (duration: 16.718067ms)","trace[1899785002] 'applied index is now lower than readState.Index' (duration: 89.672243ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:41:56.87735Z","caller":"traceutil/trace.go:171","msg":"trace[971091586] transaction","detail":"{read_only:false; response_revision:218; number_of_response:1; }","duration":"107.128314ms","start":"2026-04-08T10:41:56.770182Z","end":"2026-04-08T10:41:56.877311Z","steps":["trace[971091586] 'process raft request' (duration: 17.369438ms)","trace[971091586] 'compare' (duration: 89.319391ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:41:56.877422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.603886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T10:41:56.877469Z","caller":"traceutil/trace.go:171","msg":"trace[1364001738] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/attachdetach-controller; range_end:; response_count:0; response_revision:218; }","duration":"106.698489ms","start":"2026-04-08T10:41:56.770757Z","end":"2026-04-08T10:41:56.877456Z","steps":["trace[1364001738] 'agreement among raft nodes before linearized reading' (duration: 106.549734ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:41:57.398325Z","caller":"traceutil/trace.go:171","msg":"trace[362818428] transaction","detail":"{read_only:false; response_revision:232; number_of_response:1; }","duration":"199.529273ms","start":"2026-04-08T10:41:57.198759Z","end":"2026-04-08T10:41:57.398288Z","steps":["trace[362818428] 'process raft request' (duration: 199.406439ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:41:57.475483Z","caller":"traceutil/trace.go:171","msg":"trace[309551409] transaction","detail":"{read_only:false; response_revision:233; number_of_response:1; }","duration":"273.549189ms","start":"2026-04-08T10:41:57.201904Z","end":"2026-04-08T10:41:57.475453Z","steps":["trace[309551409] 'process raft request' (duration: 273.354993ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:42:21.223289Z","caller":"traceutil/trace.go:171","msg":"trace[1063095501] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"197.041385ms","start":"2026-04-08T10:42:21.026225Z","end":"2026-04-08T10:42:21.223267Z","steps":["trace[1063095501] 'process raft request' (duration: 196.909121ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:42:21.249068Z","caller":"traceutil/trace.go:171","msg":"trace[534698095] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"202.575344ms","start":"2026-04-08T10:42:21.046465Z","end":"2026-04-08T10:42:21.24904Z","steps":["trace[534698095] 'process raft request' (duration: 202.312596ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:42:21.249243Z","caller":"traceutil/trace.go:171","msg":"trace[354304439] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"193.223358ms","start":"2026-04-08T10:42:21.055849Z","end":"2026-04-08T10:42:21.249072Z","steps":["trace[354304439] 'process raft request' (duration: 192.993081ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:42:21.249383Z","caller":"traceutil/trace.go:171","msg":"trace[1246990073] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"208.427451ms","start":"2026-04-08T10:42:21.040947Z","end":"2026-04-08T10:42:21.249374Z","steps":["trace[1246990073] 'process raft request' (duration: 207.670631ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:42:21.249518Z","caller":"traceutil/trace.go:171","msg":"trace[570513813] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"203.108617ms","start":"2026-04-08T10:42:21.046402Z","end":"2026-04-08T10:42:21.249511Z","steps":["trace[570513813] 'process raft request' (duration: 202.345988ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:42:21.249496Z","caller":"traceutil/trace.go:171","msg":"trace[1929254710] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"193.72088ms","start":"2026-04-08T10:42:21.055758Z","end":"2026-04-08T10:42:21.249479Z","steps":["trace[1929254710] 'process raft request' (duration: 193.052442ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:42:21.24964Z","caller":"traceutil/trace.go:171","msg":"trace[292702041] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"177.295686ms","start":"2026-04-08T10:42:21.072335Z","end":"2026-04-08T10:42:21.249631Z","steps":["trace[292702041] 'process raft request' (duration: 176.678601ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:42:21.249703Z","caller":"traceutil/trace.go:171","msg":"trace[149498477] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"192.92391ms","start":"2026-04-08T10:42:21.056774Z","end":"2026-04-08T10:42:21.249698Z","steps":["trace[149498477] 'process raft request' (duration: 192.171962ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:42:21.249717Z","caller":"traceutil/trace.go:171","msg":"trace[507946345] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"149.008801ms","start":"2026-04-08T10:42:21.100677Z","end":"2026-04-08T10:42:21.249686Z","steps":["trace[507946345] 'process raft request' (duration: 148.499768ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:42:21.249765Z","caller":"traceutil/trace.go:171","msg":"trace[1829719661] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"182.059905ms","start":"2026-04-08T10:42:21.067699Z","end":"2026-04-08T10:42:21.249759Z","steps":["trace[1829719661] 'process raft request' (duration: 181.272916ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:42:21.249822Z","caller":"traceutil/trace.go:171","msg":"trace[234018149] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"139.83034ms","start":"2026-04-08T10:42:21.109965Z","end":"2026-04-08T10:42:21.249795Z","steps":["trace[234018149] 'process raft request' (duration: 139.320528ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:42:21.249917Z","caller":"traceutil/trace.go:171","msg":"trace[10348186] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"160.474471ms","start":"2026-04-08T10:42:21.089421Z","end":"2026-04-08T10:42:21.249895Z","steps":["trace[10348186] 'process raft request' (duration: 159.659971ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:42:21.259034Z","caller":"traceutil/trace.go:171","msg":"trace[1229866742] linearizableReadLoop","detail":"{readStateIndex:489; appliedIndex:479; }","duration":"158.360977ms","start":"2026-04-08T10:42:21.100652Z","end":"2026-04-08T10:42:21.259013Z","steps":["trace[1229866742] 'read index received' (duration: 122.562113ms)","trace[1229866742] 'applied index is now lower than readState.Index' (duration: 35.797704ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:42:21.268751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.339774ms","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-08T10:42:21.268848Z","caller":"traceutil/trace.go:171","msg":"trace[2144723632] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:479; }","duration":"168.228196ms","start":"2026-04-08T10:42:21.100586Z","end":"2026-04-08T10:42:21.268815Z","steps":["trace[2144723632] 'agreement among raft nodes before linearized reading' (duration: 158.50225ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:42:21.728687Z","caller":"traceutil/trace.go:171","msg":"trace[910908814] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"355.799931ms","start":"2026-04-08T10:42:21.372844Z","end":"2026-04-08T10:42:21.728644Z","steps":["trace[910908814] 'process raft request' (duration: 322.097791ms)","trace[910908814] 'compare' (duration: 32.787278ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:42:21.729316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:42:21.37279Z","time spent":"356.076539ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23057,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T10:42:21.728713Z","caller":"traceutil/trace.go:171","msg":"trace[1187462745] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"354.004737ms","start":"2026-04-08T10:42:21.374667Z","end":"2026-04-08T10:42:21.728672Z","steps":["trace[1187462745] 'process raft request' (duration: 353.460273ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:42:21.730348Z","caller":"traceutil/trace.go:171","msg":"trace[151646546] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"318.380997ms","start":"2026-04-08T10:42:21.411038Z","end":"2026-04-08T10:42:21.729419Z","steps":["trace[151646546] 'process raft request' (duration: 317.73329ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:42:21.736558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:42:21.374646Z","time spent":"361.826744ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T10:42:21.730841Z","caller":"traceutil/trace.go:171","msg":"trace[803461508] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"341.959612ms","start":"2026-04-08T10:42:21.387622Z","end":"2026-04-08T10:42:21.729582Z","steps":["trace[803461508] 'process raft request' (duration: 340.631069ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:42:21.736711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:42:21.411001Z","time spent":"325.60918ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T10:42:21.736879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:42:21.387598Z","time spent":"349.172984ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T10:42:22.820492Z","caller":"traceutil/trace.go:171","msg":"trace[266469425] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"106.547844ms","start":"2026-04-08T10:42:22.713244Z","end":"2026-04-08T10:42:22.819792Z","steps":["trace[266469425] 'process raft request' (duration: 90.430811ms)","trace[266469425] 'compare' (duration: 16.01267ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:42:22.871611Z","caller":"traceutil/trace.go:171","msg":"trace[2041317696] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"142.076342ms","start":"2026-04-08T10:42:22.729504Z","end":"2026-04-08T10:42:22.87158Z","steps":["trace[2041317696] 'process raft request' (duration: 141.631201ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:42:22.872036Z","caller":"traceutil/trace.go:171","msg":"trace[1213518711] linearizableReadLoop","detail":"{readStateIndex:559; appliedIndex:557; }","duration":"119.815466ms","start":"2026-04-08T10:42:22.752201Z","end":"2026-04-08T10:42:22.872016Z","steps":["trace[1213518711] 'read index received' (duration: 51.511818ms)","trace[1213518711] 'applied index is now lower than readState.Index' (duration: 68.303028ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:42:22.872205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.98335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"info","ts":"2026-04-08T10:42:22.87224Z","caller":"traceutil/trace.go:171","msg":"trace[1520321902] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:543; }","duration":"120.063892ms","start":"2026-04-08T10:42:22.752167Z","end":"2026-04-08T10:42:22.872231Z","steps":["trace[1520321902] 'agreement among raft nodes before linearized reading' (duration: 119.924038ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:42:28.401237Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9378074889189335496,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-08T10:42:28.901993Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9378074889189335496,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-08T10:42:29.050273Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.441252251s","expected-duration":"1s"} {"level":"info","ts":"2026-04-08T10:42:29.051142Z","caller":"traceutil/trace.go:171","msg":"trace[828502658] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"1.489362869s","start":"2026-04-08T10:42:27.561758Z","end":"2026-04-08T10:42:29.051121Z","steps":["trace[828502658] 'process raft request' (duration: 1.488920539s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:42:29.051275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:42:27.561736Z","time spent":"1.489468201s","remote":"127.0.0.1:39904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T10:42:29.140355Z","caller":"traceutil/trace.go:171","msg":"trace[1319121879] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:592; }","duration":"1.239182493s","start":"2026-04-08T10:42:27.901128Z","end":"2026-04-08T10:42:29.14031Z","steps":["trace[1319121879] 'read index received' (duration: 1.149404882s)","trace[1319121879] 'applied index is now lower than readState.Index' (duration: 89.776921ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:42:29.140395Z","caller":"traceutil/trace.go:171","msg":"trace[1808153154] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"774.262415ms","start":"2026-04-08T10:42:28.366116Z","end":"2026-04-08T10:42:29.140378Z","steps":["trace[1808153154] 'process raft request' (duration: 768.52091ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:42:29.140442Z","caller":"traceutil/trace.go:171","msg":"trace[928896218] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"583.547089ms","start":"2026-04-08T10:42:28.556888Z","end":"2026-04-08T10:42:29.140435Z","steps":["trace[928896218] 'process raft request' (duration: 583.382305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:42:29.140511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:42:28.556865Z","time spent":"583.59246ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T10:42:29.140643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:42:28.36608Z","time spent":"774.353807ms","remote":"127.0.0.1:39974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T10:42:29.140672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.239555071s","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-08T10:42:29.140801Z","caller":"traceutil/trace.go:171","msg":"trace[775148658] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:577; }","duration":"1.239724255s","start":"2026-04-08T10:42:27.901069Z","end":"2026-04-08T10:42:29.140794Z","steps":["trace[775148658] 'agreement among raft nodes before linearized reading' (duration: 1.239535051s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:42:29.140818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:42:27.901046Z","time spent":"1.239767777s","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-08T10:42:29.14957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.009365748s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hglmc\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-08T10:42:29.14964Z","caller":"traceutil/trace.go:171","msg":"trace[1115128352] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hglmc; range_end:; response_count:1; response_revision:578; }","duration":"1.009475201s","start":"2026-04-08T10:42:28.140153Z","end":"2026-04-08T10:42:29.149628Z","steps":["trace[1115128352] 'agreement among raft nodes before linearized reading' (duration: 1.009312037s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:42:29.149685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:42:28.140132Z","time spent":"1.009546742s","remote":"127.0.0.1:39978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-hglmc\" "} {"level":"warn","ts":"2026-04-08T10:42:29.149818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.761242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-08T10:42:29.149844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"795.29629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T10:42:29.14986Z","caller":"traceutil/trace.go:171","msg":"trace[2068289170] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:578; }","duration":"299.835893ms","start":"2026-04-08T10:42:28.850011Z","end":"2026-04-08T10:42:29.149847Z","steps":["trace[2068289170] 'agreement among raft nodes before linearized reading' (duration: 299.71659ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:42:29.149866Z","caller":"traceutil/trace.go:171","msg":"trace[856006250] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:578; }","duration":"795.377253ms","start":"2026-04-08T10:42:28.354481Z","end":"2026-04-08T10:42:29.149858Z","steps":["trace[856006250] 'agreement among raft nodes before linearized reading' (duration: 795.328741ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:42:29.149983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:42:28.354459Z","time spent":"795.515446ms","remote":"127.0.0.1:39794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-08T10:42:30.117526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"725.888962ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T10:42:30.118187Z","caller":"traceutil/trace.go:171","msg":"trace[662863280] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"963.79373ms","start":"2026-04-08T10:42:29.154382Z","end":"2026-04-08T10:42:30.118176Z","steps":["trace[662863280] 'process raft request' (duration: 963.671567ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:42:30.118203Z","caller":"traceutil/trace.go:171","msg":"trace[976024178] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"973.114469ms","start":"2026-04-08T10:42:29.145047Z","end":"2026-04-08T10:42:30.118162Z","steps":["trace[976024178] 'process raft request' (duration: 246.513401ms)","trace[976024178] 'compare' (duration: 725.453751ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:42:30.118247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:42:29.154366Z","time spent":"963.854482ms","remote":"127.0.0.1:40052","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-08T10:42:30.118184Z","caller":"traceutil/trace.go:171","msg":"trace[24033314] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:596; }","duration":"960.617286ms","start":"2026-04-08T10:42:29.157551Z","end":"2026-04-08T10:42:30.118168Z","steps":["trace[24033314] 'read index received' (duration: 234.018988ms)","trace[24033314] 'applied index is now lower than readState.Index' (duration: 726.597488ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:42:30.118408Z","caller":"traceutil/trace.go:171","msg":"trace[1388206613] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"955.6843ms","start":"2026-04-08T10:42:29.162713Z","end":"2026-04-08T10:42:30.118398Z","steps":["trace[1388206613] 'process raft request' (duration: 955.411324ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:42:30.118461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"960.911993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T10:42:30.11847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:42:29.162693Z","time spent":"955.749562ms","remote":"127.0.0.1:39978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T10:42:30.118495Z","caller":"traceutil/trace.go:171","msg":"trace[1234589729] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:581; }","duration":"960.970764ms","start":"2026-04-08T10:42:29.157514Z","end":"2026-04-08T10:42:30.118485Z","steps":["trace[1234589729] 'agreement among raft nodes before linearized reading' (duration: 960.920663ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:42:30.118527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:42:29.157501Z","time spent":"961.015395ms","remote":"127.0.0.1:40034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-04-08T10:42:30.118352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:42:29.145025Z","time spent":"973.248651ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T10:42:30.120066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.03702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T10:42:30.120117Z","caller":"traceutil/trace.go:171","msg":"trace[2130129337] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"766.127882ms","start":"2026-04-08T10:42:29.353976Z","end":"2026-04-08T10:42:30.120104Z","steps":["trace[2130129337] 'agreement among raft nodes before linearized reading' (duration: 766.02785ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:42:30.120177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:42:29.353966Z","time spent":"766.202625ms","remote":"127.0.0.1:39808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-08T10:42:30.120209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"776.821563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-08T10:42:30.120293Z","caller":"traceutil/trace.go:171","msg":"trace[479938810] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:581; }","duration":"776.965496ms","start":"2026-04-08T10:42:29.343306Z","end":"2026-04-08T10:42:30.120272Z","steps":["trace[479938810] 'agreement among raft nodes before linearized reading' (duration: 776.701409ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:42:30.120339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:42:29.343295Z","time spent":"777.035687ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-08T10:42:30.120089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"864.995707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-08T10:42:30.120506Z","caller":"traceutil/trace.go:171","msg":"trace[2059122783] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:581; }","duration":"865.435667ms","start":"2026-04-08T10:42:29.255056Z","end":"2026-04-08T10:42:30.120492Z","steps":["trace[2059122783] 'agreement among raft nodes before linearized reading' (duration: 864.934415ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:42:30.120634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:42:29.255022Z","time spent":"865.594761ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-08T10:42:33.523164Z","caller":"traceutil/trace.go:171","msg":"trace[835443348] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"147.94675ms","start":"2026-04-08T10:42:33.375196Z","end":"2026-04-08T10:42:33.523143Z","steps":["trace[835443348] 'process raft request' (duration: 147.840228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:42:34.508694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.548503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T10:42:34.509059Z","caller":"traceutil/trace.go:171","msg":"trace[169521159] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:651; }","duration":"135.910791ms","start":"2026-04-08T10:42:34.373117Z","end":"2026-04-08T10:42:34.509028Z","steps":["trace[169521159] 'range keys from in-memory index tree' (duration: 135.463311ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:42:34.508783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.353094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T10:42:34.509281Z","caller":"traceutil/trace.go:171","msg":"trace[2021029011] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:651; }","duration":"154.899236ms","start":"2026-04-08T10:42:34.354359Z","end":"2026-04-08T10:42:34.509258Z","steps":["trace[2021029011] 'range keys from in-memory index tree' (duration: 154.258012ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:44:06.929831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.641787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-08T10:44:06.929896Z","caller":"traceutil/trace.go:171","msg":"trace[996735066] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1142; }","duration":"106.752349ms","start":"2026-04-08T10:44:06.82313Z","end":"2026-04-08T10:44:06.929882Z","steps":["trace[996735066] 'range keys from in-memory index tree' (duration: 106.491846ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:44:06.929838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.465583ms","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-08T10:44:06.930028Z","caller":"traceutil/trace.go:171","msg":"trace[442193165] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1142; }","duration":"131.679487ms","start":"2026-04-08T10:44:06.798327Z","end":"2026-04-08T10:44:06.930007Z","steps":["trace[442193165] 'range keys from in-memory index tree' (duration: 131.348033ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:44:06.93011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.717592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-08T10:44:06.930155Z","caller":"traceutil/trace.go:171","msg":"trace[350585950] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1142; }","duration":"107.796132ms","start":"2026-04-08T10:44:06.822345Z","end":"2026-04-08T10:44:06.930141Z","steps":["trace[350585950] 'range keys from in-memory index tree' (duration: 107.61315ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:44:25.174903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.789743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-08T10:44:25.174974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.843203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-08T10:44:25.17501Z","caller":"traceutil/trace.go:171","msg":"trace[662757777] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1233; }","duration":"129.914285ms","start":"2026-04-08T10:44:25.045071Z","end":"2026-04-08T10:44:25.174985Z","steps":["trace[662757777] 'range keys from in-memory index tree' (duration: 129.551711ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:44:25.175043Z","caller":"traceutil/trace.go:171","msg":"trace[1232092740] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1233; }","duration":"108.957374ms","start":"2026-04-08T10:44:25.066068Z","end":"2026-04-08T10:44:25.175026Z","steps":["trace[1232092740] 'range keys from in-memory index tree' (duration: 108.64793ms)"],"step_count":1}