{"level":"warn","ts":"2026-05-27T00:43:47.626579Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-27T00:43:47.626662Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.144: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.144:2380","--initial-cluster=instance=https://199.204.45.144:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.144:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.144:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-27T00:43:47.626721Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-27T00:43:47.626735Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-05-27T00:43:47.626759Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-27T00:43:47.627653Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"]} {"level":"info","ts":"2026-05-27T00:43:47.627748Z","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.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.144:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-27T00:43:47.6317Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.706071ms"} {"level":"info","ts":"2026-05-27T00:43:47.640322Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4594e5f716bad646","cluster-id":"ff2e51b364668606"} {"level":"info","ts":"2026-05-27T00:43:47.640412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=()"} {"level":"info","ts":"2026-05-27T00:43:47.640478Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 0"} {"level":"info","ts":"2026-05-27T00:43:47.640492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4594e5f716bad646 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-27T00:43:47.64051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 1"} {"level":"info","ts":"2026-05-27T00:43:47.640588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"warn","ts":"2026-05-27T00:43:47.646795Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-27T00:43:47.647894Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-27T00:43:47.64897Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-27T00:43:47.650962Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4594e5f716bad646","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-27T00:43:47.651047Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4594e5f716bad646","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-27T00:43:47.65126Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-27T00:43:47.651402Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-27T00:43:47.651483Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-27T00:43:47.652789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"info","ts":"2026-05-27T00:43:47.652999Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","added-peer-id":"4594e5f716bad646","added-peer-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-05-27T00:43:47.659129Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-27T00:43:47.659321Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-05-27T00:43:47.659365Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4594e5f716bad646","initial-advertise-peer-urls":["https://199.204.45.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-27T00:43:47.659361Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-05-27T00:43:47.659424Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-27T00:43:48.240797Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 is starting a new election at term 1"} {"level":"info","ts":"2026-05-27T00:43:48.241615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-27T00:43:48.241667Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgPreVoteResp from 4594e5f716bad646 at term 1"} {"level":"info","ts":"2026-05-27T00:43:48.241722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became candidate at term 2"} {"level":"info","ts":"2026-05-27T00:43:48.241739Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgVoteResp from 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-05-27T00:43:48.241756Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became leader at term 2"} {"level":"info","ts":"2026-05-27T00:43:48.241782Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4594e5f716bad646 elected leader 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-05-27T00:43:48.244251Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4594e5f716bad646","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.144:2379]}","request-path":"/0/members/4594e5f716bad646/attributes","cluster-id":"ff2e51b364668606","publish-timeout":"7s"} {"level":"info","ts":"2026-05-27T00:43:48.244448Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T00:43:48.244485Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T00:43:48.244552Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T00:43:48.244673Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-27T00:43:48.24474Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-27T00:43:48.245292Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T00:43:48.245388Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T00:43:48.245421Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T00:43:48.247699Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.144:2379"} {"level":"info","ts":"2026-05-27T00:43:48.248263Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-27T00:43:53.396605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.184468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-05-27T00:43:53.396719Z","caller":"traceutil/trace.go:171","msg":"trace[1362468208] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:1; response_revision:257; }","duration":"170.3448ms","start":"2026-05-27T00:43:53.226354Z","end":"2026-05-27T00:43:53.396699Z","steps":["trace[1362468208] 'range keys from in-memory index tree' (duration: 170.016595ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:43:53.396916Z","caller":"traceutil/trace.go:171","msg":"trace[1082462444] transaction","detail":"{read_only:false; response_revision:258; number_of_response:1; }","duration":"158.194766ms","start":"2026-05-27T00:43:53.238688Z","end":"2026-05-27T00:43:53.396882Z","steps":["trace[1082462444] 'process raft request' (duration: 103.130668ms)","trace[1082462444] 'compare' (duration: 54.779042ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:43:56.237614Z","caller":"traceutil/trace.go:171","msg":"trace[825583620] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"113.288795ms","start":"2026-05-27T00:43:56.124272Z","end":"2026-05-27T00:43:56.237561Z","steps":["trace[825583620] 'process raft request' (duration: 113.133093ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:43:56.570581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.113913ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T00:43:56.570703Z","caller":"traceutil/trace.go:171","msg":"trace[1588530810] linearizableReadLoop","detail":"{readStateIndex:306; appliedIndex:305; }","duration":"327.486205ms","start":"2026-05-27T00:43:56.243199Z","end":"2026-05-27T00:43:56.570685Z","steps":["trace[1588530810] 'read index received' (duration: 151.181039ms)","trace[1588530810] 'applied index is now lower than readState.Index' (duration: 176.303816ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:43:56.570829Z","caller":"traceutil/trace.go:171","msg":"trace[123905001] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"327.72372ms","start":"2026-05-27T00:43:56.243061Z","end":"2026-05-27T00:43:56.570785Z","steps":["trace[123905001] 'process raft request' (duration: 151.276872ms)","trace[123905001] 'compare' (duration: 174.858177ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:43:56.570865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.660679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-27T00:43:56.571Z","caller":"traceutil/trace.go:171","msg":"trace[1211180962] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:293; }","duration":"327.830212ms","start":"2026-05-27T00:43:56.243157Z","end":"2026-05-27T00:43:56.570987Z","steps":["trace[1211180962] 'agreement among raft nodes before linearized reading' (duration: 327.574877ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:43:56.571043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:43:56.243139Z","time spent":"327.892253ms","remote":"127.0.0.1:46248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-27T00:43:56.57105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:43:56.243047Z","time spent":"327.884403ms","remote":"127.0.0.1:46386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T00:43:56.718116Z","caller":"traceutil/trace.go:171","msg":"trace[37216906] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"142.48652ms","start":"2026-05-27T00:43:56.57559Z","end":"2026-05-27T00:43:56.718077Z","steps":["trace[37216906] 'process raft request' (duration: 104.698968ms)","trace[37216906] 'compare' (duration: 37.649829ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:44:31.453991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.838351ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T00:44:31.454234Z","caller":"traceutil/trace.go:171","msg":"trace[974425375] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"210.824275ms","start":"2026-05-27T00:44:31.243384Z","end":"2026-05-27T00:44:31.454208Z","steps":["trace[974425375] 'process raft request' (duration: 89.688108ms)","trace[974425375] 'compare' (duration: 120.449734ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:44:31.853955Z","caller":"traceutil/trace.go:171","msg":"trace[457593513] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"423.399099ms","start":"2026-05-27T00:44:31.430521Z","end":"2026-05-27T00:44:31.85392Z","steps":["trace[457593513] 'process raft request' (duration: 381.152452ms)","trace[457593513] 'compare' (duration: 41.827069ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:44:31.854053Z","caller":"traceutil/trace.go:171","msg":"trace[764941882] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"395.569909ms","start":"2026-05-27T00:44:31.458454Z","end":"2026-05-27T00:44:31.854024Z","steps":["trace[764941882] 'process raft request' (duration: 395.437206ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:44:31.854233Z","caller":"traceutil/trace.go:171","msg":"trace[1128625744] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"397.810303ms","start":"2026-05-27T00:44:31.4564Z","end":"2026-05-27T00:44:31.85421Z","steps":["trace[1128625744] 'read index received' (duration: 355.131658ms)","trace[1128625744] 'applied index is now lower than readState.Index' (duration: 42.676295ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:44:31.854428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:44:31.458432Z","time spent":"395.819174ms","remote":"127.0.0.1:46386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T00:44:31.854446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:44:31.430493Z","time spent":"423.741365ms","remote":"127.0.0.1:46234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T00:44:31.854438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.025127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-05-27T00:44:31.854607Z","caller":"traceutil/trace.go:171","msg":"trace[1572250214] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:592; }","duration":"398.289922ms","start":"2026-05-27T00:44:31.456305Z","end":"2026-05-27T00:44:31.854595Z","steps":["trace[1572250214] 'agreement among raft nodes before linearized reading' (duration: 398.023727ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:44:31.854649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:44:31.456286Z","time spent":"398.351873ms","remote":"127.0.0.1:46280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":445,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-05-27T00:45:21.479749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.486408ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T00:45:21.479976Z","caller":"traceutil/trace.go:171","msg":"trace[636138761] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"200.484523ms","start":"2026-05-27T00:45:21.279466Z","end":"2026-05-27T00:45:21.479951Z","steps":["trace[636138761] 'process raft request' (duration: 10.650548ms)","trace[636138761] 'compare' (duration: 188.536879ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:45:42.647744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.297562ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T00:45:42.647936Z","caller":"traceutil/trace.go:171","msg":"trace[1716858133] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"343.550372ms","start":"2026-05-27T00:45:42.304364Z","end":"2026-05-27T00:45:42.647914Z","steps":["trace[1716858133] 'process raft request' (duration: 173.985355ms)","trace[1716858133] 'compare' (duration: 169.147319ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:45:42.648013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:45:42.304346Z","time spent":"343.630964ms","remote":"127.0.0.1:46386","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-05-27T00:45:42.648094Z","caller":"traceutil/trace.go:171","msg":"trace[1392325397] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"343.48862ms","start":"2026-05-27T00:45:42.30457Z","end":"2026-05-27T00:45:42.648059Z","steps":["trace[1392325397] 'process raft request' (duration: 343.291166ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:45:42.648203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:45:42.304561Z","time spent":"343.582022ms","remote":"127.0.0.1:46386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T00:45:43.282609Z","caller":"traceutil/trace.go:171","msg":"trace[1302932593] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"126.098418ms","start":"2026-05-27T00:45:43.156486Z","end":"2026-05-27T00:45:43.282584Z","steps":["trace[1302932593] 'process raft request' (duration: 125.947745ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:45:43.507127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.528536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T00:45:43.507235Z","caller":"traceutil/trace.go:171","msg":"trace[423852947] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1037; }","duration":"125.653188ms","start":"2026-05-27T00:45:43.381558Z","end":"2026-05-27T00:45:43.507211Z","steps":["trace[423852947] 'count revisions from in-memory index tree' (duration: 125.368363ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:45:46.774394Z","caller":"traceutil/trace.go:171","msg":"trace[1112362520] linearizableReadLoop","detail":"{readStateIndex:1093; appliedIndex:1092; }","duration":"104.552525ms","start":"2026-05-27T00:45:46.669818Z","end":"2026-05-27T00:45:46.77437Z","steps":["trace[1112362520] 'read index received' (duration: 104.241759ms)","trace[1112362520] 'applied index is now lower than readState.Index' (duration: 309.916µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:45:46.774436Z","caller":"traceutil/trace.go:171","msg":"trace[896519794] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"109.89582ms","start":"2026-05-27T00:45:46.66451Z","end":"2026-05-27T00:45:46.774406Z","steps":["trace[896519794] 'process raft request' (duration: 109.690166ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:45:46.774964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.78192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-27T00:45:46.775015Z","caller":"traceutil/trace.go:171","msg":"trace[248131985] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1047; }","duration":"105.200337ms","start":"2026-05-27T00:45:46.669801Z","end":"2026-05-27T00:45:46.775001Z","steps":["trace[248131985] 'agreement among raft nodes before linearized reading' (duration: 104.671087ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:45:46.903634Z","caller":"traceutil/trace.go:171","msg":"trace[2033083247] linearizableReadLoop","detail":"{readStateIndex:1094; appliedIndex:1093; }","duration":"118.60667ms","start":"2026-05-27T00:45:46.784979Z","end":"2026-05-27T00:45:46.903586Z","steps":["trace[2033083247] 'read index received' (duration: 116.617972ms)","trace[2033083247] 'applied index is now lower than readState.Index' (duration: 1.986308ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:45:46.903723Z","caller":"traceutil/trace.go:171","msg":"trace[2120426391] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"124.76593ms","start":"2026-05-27T00:45:46.778929Z","end":"2026-05-27T00:45:46.903695Z","steps":["trace[2120426391] 'process raft request' (duration: 122.64821ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:45:46.903772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.765233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:45:46.903813Z","caller":"traceutil/trace.go:171","msg":"trace[827084944] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1048; }","duration":"118.853725ms","start":"2026-05-27T00:45:46.784949Z","end":"2026-05-27T00:45:46.903802Z","steps":["trace[827084944] 'agreement among raft nodes before linearized reading' (duration: 118.756884ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:46:01.736276Z","caller":"traceutil/trace.go:171","msg":"trace[202122164] transaction","detail":"{read_only:false; response_revision:1149; number_of_response:1; }","duration":"105.154347ms","start":"2026-05-27T00:46:01.631075Z","end":"2026-05-27T00:46:01.73623Z","steps":["trace[202122164] 'process raft request' (duration: 93.018779ms)","trace[202122164] 'compare' (duration: 11.913623ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:46:17.955881Z","caller":"traceutil/trace.go:171","msg":"trace[1175642027] linearizableReadLoop","detail":"{readStateIndex:1276; appliedIndex:1275; }","duration":"117.771194ms","start":"2026-05-27T00:46:17.838085Z","end":"2026-05-27T00:46:17.955856Z","steps":["trace[1175642027] 'read index received' (duration: 117.600991ms)","trace[1175642027] 'applied index is now lower than readState.Index' (duration: 169.253µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:46:17.955992Z","caller":"traceutil/trace.go:171","msg":"trace[196092293] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"145.967816ms","start":"2026-05-27T00:46:17.809988Z","end":"2026-05-27T00:46:17.955956Z","steps":["trace[196092293] 'process raft request' (duration: 145.716891ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:46:17.956026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.923877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:46:17.956068Z","caller":"traceutil/trace.go:171","msg":"trace[2098478009] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1222; }","duration":"118.037939ms","start":"2026-05-27T00:46:17.838017Z","end":"2026-05-27T00:46:17.956055Z","steps":["trace[2098478009] 'agreement among raft nodes before linearized reading' (duration: 117.951557ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:46:19.072798Z","caller":"traceutil/trace.go:171","msg":"trace[577972571] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"147.948555ms","start":"2026-05-27T00:46:18.924814Z","end":"2026-05-27T00:46:19.072762Z","steps":["trace[577972571] 'process raft request' (duration: 147.762802ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:46:19.07819Z","caller":"traceutil/trace.go:171","msg":"trace[1271216159] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"149.074578ms","start":"2026-05-27T00:46:18.929084Z","end":"2026-05-27T00:46:19.078159Z","steps":["trace[1271216159] 'process raft request' (duration: 148.908035ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:46:19.611047Z","caller":"traceutil/trace.go:171","msg":"trace[2130644179] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"126.604837ms","start":"2026-05-27T00:46:19.484419Z","end":"2026-05-27T00:46:19.611024Z","steps":["trace[2130644179] 'process raft request' (duration: 125.954594ms)"],"step_count":1}