{"level":"warn","ts":"2026-04-12T20:50:15.148001Z","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-12T20:50:15.148084Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.127: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.127:2380","--initial-cluster=instance=https://199.19.213.127:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.127:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.127: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-12T20:50:15.148152Z","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-12T20:50:15.148163Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.127:2380"]} {"level":"info","ts":"2026-04-12T20:50:15.148181Z","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-12T20:50:15.148797Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.127:2379"]} {"level":"info","ts":"2026-04-12T20:50:15.148879Z","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.127:2380"],"listen-peer-urls":["https://199.19.213.127:2380"],"advertise-client-urls":["https://199.19.213.127:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.127:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.127: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-12T20:50:15.155166Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.596044ms"} {"level":"info","ts":"2026-04-12T20:50:15.164235Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"975f045ff4f5c0fb","cluster-id":"b3df79a2daf9b6ed"} {"level":"info","ts":"2026-04-12T20:50:15.164308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"975f045ff4f5c0fb switched to configuration voters=()"} {"level":"info","ts":"2026-04-12T20:50:15.164326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"975f045ff4f5c0fb became follower at term 0"} {"level":"info","ts":"2026-04-12T20:50:15.164339Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 975f045ff4f5c0fb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-12T20:50:15.164348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"975f045ff4f5c0fb became follower at term 1"} {"level":"info","ts":"2026-04-12T20:50:15.164384Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"975f045ff4f5c0fb switched to configuration voters=(10907441632692781307)"} {"level":"warn","ts":"2026-04-12T20:50:15.171988Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-12T20:50:15.173629Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-12T20:50:15.174779Z","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-12T20:50:15.17747Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"975f045ff4f5c0fb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-12T20:50:15.177667Z","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-12T20:50:15.177801Z","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-12T20:50:15.177819Z","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-12T20:50:15.178207Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"975f045ff4f5c0fb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-12T20:50:15.182802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"975f045ff4f5c0fb switched to configuration voters=(10907441632692781307)"} {"level":"info","ts":"2026-04-12T20:50:15.183014Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b3df79a2daf9b6ed","local-member-id":"975f045ff4f5c0fb","added-peer-id":"975f045ff4f5c0fb","added-peer-peer-urls":["https://199.19.213.127:2380"]} {"level":"info","ts":"2026-04-12T20:50:15.185961Z","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-12T20:50:15.186148Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"975f045ff4f5c0fb","initial-advertise-peer-urls":["https://199.19.213.127:2380"],"listen-peer-urls":["https://199.19.213.127:2380"],"advertise-client-urls":["https://199.19.213.127:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.127:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-12T20:50:15.18618Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-12T20:50:15.186188Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.127:2380"} {"level":"info","ts":"2026-04-12T20:50:15.18813Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.127:2380"} {"level":"info","ts":"2026-04-12T20:50:15.665241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"975f045ff4f5c0fb is starting a new election at term 1"} {"level":"info","ts":"2026-04-12T20:50:15.665368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"975f045ff4f5c0fb became pre-candidate at term 1"} {"level":"info","ts":"2026-04-12T20:50:15.665396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"975f045ff4f5c0fb received MsgPreVoteResp from 975f045ff4f5c0fb at term 1"} {"level":"info","ts":"2026-04-12T20:50:15.665416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"975f045ff4f5c0fb became candidate at term 2"} {"level":"info","ts":"2026-04-12T20:50:15.665427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"975f045ff4f5c0fb received MsgVoteResp from 975f045ff4f5c0fb at term 2"} {"level":"info","ts":"2026-04-12T20:50:15.665442Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"975f045ff4f5c0fb became leader at term 2"} {"level":"info","ts":"2026-04-12T20:50:15.665462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 975f045ff4f5c0fb elected leader 975f045ff4f5c0fb at term 2"} {"level":"info","ts":"2026-04-12T20:50:15.667436Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-12T20:50:15.667824Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"975f045ff4f5c0fb","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.127:2379]}","request-path":"/0/members/975f045ff4f5c0fb/attributes","cluster-id":"b3df79a2daf9b6ed","publish-timeout":"7s"} {"level":"info","ts":"2026-04-12T20:50:15.668402Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b3df79a2daf9b6ed","local-member-id":"975f045ff4f5c0fb","cluster-version":"3.5"} {"level":"info","ts":"2026-04-12T20:50:15.668518Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-12T20:50:15.668544Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-12T20:50:15.668557Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-12T20:50:15.668888Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-12T20:50:15.669913Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-12T20:50:15.669936Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-12T20:50:15.670895Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-12T20:50:15.691862Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.127:2379"} {"level":"warn","ts":"2026-04-12T20:50:17.212181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.397863ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-04-12T20:50:17.212456Z","caller":"traceutil/trace.go:171","msg":"trace[1172861231] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:5; }","duration":"294.426011ms","start":"2026-04-12T20:50:16.917994Z","end":"2026-04-12T20:50:17.21242Z","steps":["trace[1172861231] 'read index received' (duration: 102.345749ms)","trace[1172861231] 'applied index is now lower than readState.Index' (duration: 192.077162ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T20:50:17.212663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.629527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-12T20:50:17.212689Z","caller":"traceutil/trace.go:171","msg":"trace[1387834073] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:0; response_revision:8; }","duration":"294.714399ms","start":"2026-04-12T20:50:16.917967Z","end":"2026-04-12T20:50:17.212682Z","steps":["trace[1387834073] 'agreement among raft nodes before linearized reading' (duration: 294.598806ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:50:17.212769Z","caller":"traceutil/trace.go:171","msg":"trace[482577222] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"236.949784ms","start":"2026-04-12T20:50:16.975801Z","end":"2026-04-12T20:50:17.21275Z","steps":["trace[482577222] 'process raft request' (duration: 236.603615ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:50:17.21287Z","caller":"traceutil/trace.go:171","msg":"trace[173416004] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"236.592545ms","start":"2026-04-12T20:50:16.976259Z","end":"2026-04-12T20:50:17.212851Z","steps":["trace[173416004] 'process raft request' (duration: 236.172463ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:50:17.212821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.057996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-12T20:50:17.212981Z","caller":"traceutil/trace.go:171","msg":"trace[2115090335] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"237.319964ms","start":"2026-04-12T20:50:16.975618Z","end":"2026-04-12T20:50:17.212938Z","steps":["trace[2115090335] 'process raft request' (duration: 236.677097ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:50:17.213049Z","caller":"traceutil/trace.go:171","msg":"trace[2026977807] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"237.340385ms","start":"2026-04-12T20:50:16.975703Z","end":"2026-04-12T20:50:17.213044Z","steps":["trace[2026977807] 'process raft request' (duration: 236.654676ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:50:17.213097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.583704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-12T20:50:17.213126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.99157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-12T20:50:17.213133Z","caller":"traceutil/trace.go:171","msg":"trace[2110965022] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"185.679106ms","start":"2026-04-12T20:50:17.027446Z","end":"2026-04-12T20:50:17.213125Z","steps":["trace[2110965022] 'agreement among raft nodes before linearized reading' (duration: 185.603464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:50:17.213162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.387798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-12T20:50:17.213177Z","caller":"traceutil/trace.go:171","msg":"trace[158156877] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"236.43092ms","start":"2026-04-12T20:50:16.97674Z","end":"2026-04-12T20:50:17.213171Z","steps":["trace[158156877] 'agreement among raft nodes before linearized reading' (duration: 236.413159ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:50:17.213201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.35779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-12T20:50:17.21323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.748549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-12T20:50:17.213246Z","caller":"traceutil/trace.go:171","msg":"trace[2131686298] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"236.79335ms","start":"2026-04-12T20:50:16.976448Z","end":"2026-04-12T20:50:17.213241Z","steps":["trace[2131686298] 'agreement among raft nodes before linearized reading' (duration: 236.77076ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:50:17.213242Z","caller":"traceutil/trace.go:171","msg":"trace[1884483861] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"243.445732ms","start":"2026-04-12T20:50:16.969786Z","end":"2026-04-12T20:50:17.213232Z","steps":["trace[1884483861] 'agreement among raft nodes before linearized reading' (duration: 243.391601ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:50:17.213015Z","caller":"traceutil/trace.go:171","msg":"trace[728452985] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"237.370546ms","start":"2026-04-12T20:50:16.975637Z","end":"2026-04-12T20:50:17.213008Z","steps":["trace[728452985] 'process raft request' (duration: 236.697978ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:50:17.213327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.980328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.127\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-12T20:50:17.213349Z","caller":"traceutil/trace.go:171","msg":"trace[668028873] range","detail":"{range_begin:/registry/masterleases/199.19.213.127; range_end:; response_count:0; response_revision:11; }","duration":"240.013828ms","start":"2026-04-12T20:50:16.973331Z","end":"2026-04-12T20:50:17.213345Z","steps":["trace[668028873] 'agreement among raft nodes before linearized reading' (duration: 239.982607ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:50:17.212797Z","caller":"traceutil/trace.go:171","msg":"trace[698061433] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"236.989236ms","start":"2026-04-12T20:50:16.975741Z","end":"2026-04-12T20:50:17.21273Z","steps":["trace[698061433] 'process raft request' (duration: 236.637136ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:50:17.213015Z","caller":"traceutil/trace.go:171","msg":"trace[1058896854] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"265.295772ms","start":"2026-04-12T20:50:16.947706Z","end":"2026-04-12T20:50:17.213002Z","steps":["trace[1058896854] 'agreement among raft nodes before linearized reading' (duration: 265.066076ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:50:17.213558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.820674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-12T20:50:17.213646Z","caller":"traceutil/trace.go:171","msg":"trace[1338320759] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:11; }","duration":"168.981538ms","start":"2026-04-12T20:50:17.044651Z","end":"2026-04-12T20:50:17.213633Z","steps":["trace[1338320759] 'agreement among raft nodes before linearized reading' (duration: 168.808053ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:50:17.213667Z","caller":"traceutil/trace.go:171","msg":"trace[1685008468] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"220.255546ms","start":"2026-04-12T20:50:16.993399Z","end":"2026-04-12T20:50:17.213654Z","steps":["trace[1685008468] 'process raft request' (duration: 219.334731ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:50:17.213607Z","caller":"traceutil/trace.go:171","msg":"trace[1348624990] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"227.247348ms","start":"2026-04-12T20:50:16.986336Z","end":"2026-04-12T20:50:17.21358Z","steps":["trace[1348624990] 'process raft request' (duration: 226.348813ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:50:17.213145Z","caller":"traceutil/trace.go:171","msg":"trace[1861887630] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"243.053112ms","start":"2026-04-12T20:50:16.970087Z","end":"2026-04-12T20:50:17.21314Z","steps":["trace[1861887630] 'agreement among raft nodes before linearized reading' (duration: 243.017871ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:50:17.213902Z","caller":"traceutil/trace.go:171","msg":"trace[336629804] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"296.324353ms","start":"2026-04-12T20:50:16.915996Z","end":"2026-04-12T20:50:17.21232Z","steps":["trace[336629804] 'process raft request' (duration: 104.21347ms)","trace[336629804] 'compare' (duration: 191.258839ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T20:50:51.131706Z","caller":"traceutil/trace.go:171","msg":"trace[613673935] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"127.962544ms","start":"2026-04-12T20:50:51.003684Z","end":"2026-04-12T20:50:51.131646Z","steps":["trace[613673935] 'process raft request' (duration: 127.751258ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:50:51.340412Z","caller":"traceutil/trace.go:171","msg":"trace[336469182] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"108.009677ms","start":"2026-04-12T20:50:51.232366Z","end":"2026-04-12T20:50:51.340376Z","steps":["trace[336469182] 'process raft request' (duration: 107.424141ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:50:51.765264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.78704ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-12T20:50:51.765371Z","caller":"traceutil/trace.go:171","msg":"trace[990810446] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:632; }","duration":"328.298218ms","start":"2026-04-12T20:50:51.437035Z","end":"2026-04-12T20:50:51.765334Z","steps":["trace[990810446] 'read index received' (duration: 25.326953ms)","trace[990810446] 'applied index is now lower than readState.Index' (duration: 302.970525ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T20:50:51.765424Z","caller":"traceutil/trace.go:171","msg":"trace[1045923287] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"365.441115ms","start":"2026-04-12T20:50:51.399976Z","end":"2026-04-12T20:50:51.765417Z","steps":["trace[1045923287] 'process raft request' (duration: 62.45006ms)","trace[1045923287] 'compare' (duration: 302.703728ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T20:50:51.765457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T20:50:51.39994Z","time spent":"365.501907ms","remote":"127.0.0.1:55734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-12T20:50:51.765744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.703149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-6ttcl\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-12T20:50:51.765782Z","caller":"traceutil/trace.go:171","msg":"trace[115578362] range","detail":"{range_begin:/registry/pods/kube-system/cilium-6ttcl; range_end:; response_count:1; response_revision:615; }","duration":"328.779741ms","start":"2026-04-12T20:50:51.436991Z","end":"2026-04-12T20:50:51.765771Z","steps":["trace[115578362] 'agreement among raft nodes before linearized reading' (duration: 328.586296ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:50:51.765806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T20:50:51.436977Z","time spent":"328.823303ms","remote":"127.0.0.1:55384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-6ttcl\" "} {"level":"warn","ts":"2026-04-12T20:50:51.766455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.431598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T20:50:51.766718Z","caller":"traceutil/trace.go:171","msg":"trace[1063160887] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"154.941712ms","start":"2026-04-12T20:50:51.611747Z","end":"2026-04-12T20:50:51.766689Z","steps":["trace[1063160887] 'agreement among raft nodes before linearized reading' (duration: 154.374376ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:50:51.767247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.396373ms","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-12T20:50:51.767294Z","caller":"traceutil/trace.go:171","msg":"trace[266953250] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:615; }","duration":"194.481166ms","start":"2026-04-12T20:50:51.5728Z","end":"2026-04-12T20:50:51.767281Z","steps":["trace[266953250] 'agreement among raft nodes before linearized reading' (duration: 192.746838ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:51:41.67838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.117018ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-12T20:51:41.678497Z","caller":"traceutil/trace.go:171","msg":"trace[1951911914] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"264.514324ms","start":"2026-04-12T20:51:41.413959Z","end":"2026-04-12T20:51:41.678474Z","steps":["trace[1951911914] 'process raft request' (duration: 128.220092ms)","trace[1951911914] 'compare' (duration: 136.012375ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T20:52:05.355459Z","caller":"traceutil/trace.go:171","msg":"trace[179240868] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"151.1574ms","start":"2026-04-12T20:52:05.204274Z","end":"2026-04-12T20:52:05.355432Z","steps":["trace[179240868] 'process raft request' (duration: 151.005326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:52:37.985523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.628085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-12T20:52:37.985651Z","caller":"traceutil/trace.go:171","msg":"trace[1386772275] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1238; }","duration":"166.80224ms","start":"2026-04-12T20:52:37.818827Z","end":"2026-04-12T20:52:37.985629Z","steps":["trace[1386772275] 'count revisions from in-memory index tree' (duration: 166.43816ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:52:38.0844Z","caller":"traceutil/trace.go:171","msg":"trace[886498569] linearizableReadLoop","detail":"{readStateIndex:1282; appliedIndex:1281; }","duration":"110.233659ms","start":"2026-04-12T20:52:37.974142Z","end":"2026-04-12T20:52:38.084376Z","steps":["trace[886498569] 'read index received' (duration: 110.084385ms)","trace[886498569] 'applied index is now lower than readState.Index' (duration: 148.464µs)"],"step_count":2} {"level":"info","ts":"2026-04-12T20:52:38.084585Z","caller":"traceutil/trace.go:171","msg":"trace[1543971832] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"192.0783ms","start":"2026-04-12T20:52:37.892482Z","end":"2026-04-12T20:52:38.08456Z","steps":["trace[1543971832] 'process raft request' (duration: 191.729931ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T20:52:38.084652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.497206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-12T20:52:38.084718Z","caller":"traceutil/trace.go:171","msg":"trace[448808099] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1239; }","duration":"110.615549ms","start":"2026-04-12T20:52:37.974089Z","end":"2026-04-12T20:52:38.084705Z","steps":["trace[448808099] 'agreement among raft nodes before linearized reading' (duration: 110.408754ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T20:52:38.825185Z","caller":"traceutil/trace.go:171","msg":"trace[790818708] linearizableReadLoop","detail":"{readStateIndex:1287; appliedIndex:1286; }","duration":"112.581254ms","start":"2026-04-12T20:52:38.712584Z","end":"2026-04-12T20:52:38.825165Z","steps":["trace[790818708] 'read index received' (duration: 97.630864ms)","trace[790818708] 'applied index is now lower than readState.Index' (duration: 14.94961ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T20:52:38.825281Z","caller":"traceutil/trace.go:171","msg":"trace[1665634805] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"139.778779ms","start":"2026-04-12T20:52:38.685456Z","end":"2026-04-12T20:52:38.825235Z","steps":["trace[1665634805] 'process raft request' (duration: 124.803558ms)","trace[1665634805] 'compare' (duration: 14.806157ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T20:52:38.825457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.871122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-12T20:52:38.825513Z","caller":"traceutil/trace.go:171","msg":"trace[608763013] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1243; }","duration":"112.996985ms","start":"2026-04-12T20:52:38.712505Z","end":"2026-04-12T20:52:38.825502Z","steps":["trace[608763013] 'agreement among raft nodes before linearized reading' (duration: 112.78979ms)"],"step_count":1}