{"level":"warn","ts":"2026-03-20T10:10:02.470385Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-20T10:10:02.470538Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.122: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.122:2380","--initial-cluster=instance=https://199.19.213.122:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.122:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.122: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-03-20T10:10:02.470632Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-20T10:10:02.470664Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.122:2380"]}
{"level":"info","ts":"2026-03-20T10:10:02.470686Z","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-03-20T10:10:02.471421Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.122:2379"]}
{"level":"info","ts":"2026-03-20T10:10:02.471516Z","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.122:2380"],"listen-peer-urls":["https://199.19.213.122:2380"],"advertise-client-urls":["https://199.19.213.122:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.122:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.122: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-03-20T10:10:02.475941Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.170185ms"}
{"level":"info","ts":"2026-03-20T10:10:02.485415Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f9ba8c11acfbc749","cluster-id":"ca7c3e103d4cd533"}
{"level":"info","ts":"2026-03-20T10:10:02.485549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f9ba8c11acfbc749 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-20T10:10:02.485613Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f9ba8c11acfbc749 became follower at term 0"}
{"level":"info","ts":"2026-03-20T10:10:02.485639Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f9ba8c11acfbc749 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-20T10:10:02.485695Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f9ba8c11acfbc749 became follower at term 1"}
{"level":"info","ts":"2026-03-20T10:10:02.485776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f9ba8c11acfbc749 switched to configuration voters=(17994849268656752457)"}
{"level":"warn","ts":"2026-03-20T10:10:02.49351Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-20T10:10:02.495444Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-20T10:10:02.496677Z","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-03-20T10:10:02.499728Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f9ba8c11acfbc749","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-20T10:10:02.499979Z","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-03-20T10:10:02.500094Z","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-03-20T10:10:02.500151Z","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-03-20T10:10:02.500554Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f9ba8c11acfbc749","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-20T10:10:02.503251Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f9ba8c11acfbc749 switched to configuration voters=(17994849268656752457)"}
{"level":"info","ts":"2026-03-20T10:10:02.503365Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ca7c3e103d4cd533","local-member-id":"f9ba8c11acfbc749","added-peer-id":"f9ba8c11acfbc749","added-peer-peer-urls":["https://199.19.213.122:2380"]}
{"level":"info","ts":"2026-03-20T10:10:02.504329Z","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-03-20T10:10:02.504562Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f9ba8c11acfbc749","initial-advertise-peer-urls":["https://199.19.213.122:2380"],"listen-peer-urls":["https://199.19.213.122:2380"],"advertise-client-urls":["https://199.19.213.122:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.122:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-20T10:10:02.504602Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-20T10:10:02.505191Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.122:2380"}
{"level":"info","ts":"2026-03-20T10:10:02.505234Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.122:2380"}
{"level":"info","ts":"2026-03-20T10:10:03.38697Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f9ba8c11acfbc749 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-20T10:10:03.387045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f9ba8c11acfbc749 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-20T10:10:03.387091Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f9ba8c11acfbc749 received MsgPreVoteResp from f9ba8c11acfbc749 at term 1"}
{"level":"info","ts":"2026-03-20T10:10:03.387116Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f9ba8c11acfbc749 became candidate at term 2"}
{"level":"info","ts":"2026-03-20T10:10:03.387132Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f9ba8c11acfbc749 received MsgVoteResp from f9ba8c11acfbc749 at term 2"}
{"level":"info","ts":"2026-03-20T10:10:03.387153Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f9ba8c11acfbc749 became leader at term 2"}
{"level":"info","ts":"2026-03-20T10:10:03.387229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f9ba8c11acfbc749 elected leader f9ba8c11acfbc749 at term 2"}
{"level":"info","ts":"2026-03-20T10:10:03.403166Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f9ba8c11acfbc749","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.122:2379]}","request-path":"/0/members/f9ba8c11acfbc749/attributes","cluster-id":"ca7c3e103d4cd533","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-20T10:10:03.403337Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-20T10:10:03.403606Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-20T10:10:03.403635Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-20T10:10:03.405573Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T10:10:03.403215Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-20T10:10:03.407777Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.122:2379"}
{"level":"info","ts":"2026-03-20T10:10:03.408817Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-20T10:10:03.427989Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ca7c3e103d4cd533","local-member-id":"f9ba8c11acfbc749","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T10:10:03.428069Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T10:10:03.428097Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"warn","ts":"2026-03-20T10:10:05.898794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.214543ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14360181556229862910 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterroles/admin\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/admin\" value_size:571 >> failure:<>>","response":"size:14"}
{"level":"info","ts":"2026-03-20T10:10:05.899141Z","caller":"traceutil/trace.go:171","msg":"trace[1777102634] linearizableReadLoop","detail":"{readStateIndex:87; appliedIndex:85; }","duration":"157.977787ms","start":"2026-03-20T10:10:05.741138Z","end":"2026-03-20T10:10:05.899116Z","steps":["trace[1777102634] 'read index received'  (duration: 53.820467ms)","trace[1777102634] 'applied index is now lower than readState.Index'  (duration: 104.156ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:10:05.899121Z","caller":"traceutil/trace.go:171","msg":"trace[1403475591] transaction","detail":"{read_only:false; response_revision:82; number_of_response:1; }","duration":"166.516795ms","start":"2026-03-20T10:10:05.732565Z","end":"2026-03-20T10:10:05.899082Z","steps":["trace[1403475591] 'process raft request'  (duration: 62.412457ms)","trace[1403475591] 'compare'  (duration: 103.036305ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:10:05.89935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.125724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-20T10:10:05.899447Z","caller":"traceutil/trace.go:171","msg":"trace[798377019] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:82; }","duration":"158.322994ms","start":"2026-03-20T10:10:05.74111Z","end":"2026-03-20T10:10:05.899433Z","steps":["trace[798377019] 'agreement among raft nodes before linearized reading'  (duration: 158.121544ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:06.276825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.431376ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14360181556229862940 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/default/instance.189e84df9bf4b68f\" mod_revision:92 > success:<request_put:<key:\"/registry/events/default/instance.189e84df9bf4b68f\" value_size:574 lease:5136809519375087103 >> failure:<request_range:<key:\"/registry/events/default/instance.189e84df9bf4b68f\" > >>","response":"size:14"}
{"level":"info","ts":"2026-03-20T10:10:06.276964Z","caller":"traceutil/trace.go:171","msg":"trace[358537187] linearizableReadLoop","detail":"{readStateIndex:103; appliedIndex:102; }","duration":"172.083684ms","start":"2026-03-20T10:10:06.104858Z","end":"2026-03-20T10:10:06.276942Z","steps":["trace[358537187] 'read index received'  (duration: 59.216316ms)","trace[358537187] 'applied index is now lower than readState.Index'  (duration: 112.865978ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:10:06.277051Z","caller":"traceutil/trace.go:171","msg":"trace[2103838167] transaction","detail":"{read_only:false; response_revision:98; number_of_response:1; }","duration":"172.373849ms","start":"2026-03-20T10:10:06.104621Z","end":"2026-03-20T10:10:06.276995Z","steps":["trace[2103838167] 'process raft request'  (duration: 59.393826ms)","trace[2103838167] 'compare'  (duration: 112.258687ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:10:06.277074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.20478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:node-problem-detector\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-20T10:10:06.277123Z","caller":"traceutil/trace.go:171","msg":"trace[638736623] range","detail":"{range_begin:/registry/clusterroles/system:node-problem-detector; range_end:; response_count:0; response_revision:98; }","duration":"172.269554ms","start":"2026-03-20T10:10:06.104841Z","end":"2026-03-20T10:10:06.27711Z","steps":["trace[638736623] 'agreement among raft nodes before linearized reading'  (duration: 172.156848ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:06.501588Z","caller":"traceutil/trace.go:171","msg":"trace[1322725459] linearizableReadLoop","detail":"{readStateIndex:108; appliedIndex:107; }","duration":"180.786184ms","start":"2026-03-20T10:10:06.32077Z","end":"2026-03-20T10:10:06.501556Z","steps":["trace[1322725459] 'read index received'  (duration: 127.541962ms)","trace[1322725459] 'applied index is now lower than readState.Index'  (duration: 53.242772ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:10:06.501876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.072398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.189e84df9bf4b68f\" ","response":"range_response_count:1 size:654"}
{"level":"info","ts":"2026-03-20T10:10:06.501884Z","caller":"traceutil/trace.go:171","msg":"trace[1238184556] transaction","detail":"{read_only:false; response_revision:103; number_of_response:1; }","duration":"181.410745ms","start":"2026-03-20T10:10:06.320292Z","end":"2026-03-20T10:10:06.501703Z","steps":["trace[1238184556] 'process raft request'  (duration: 128.004565ms)","trace[1238184556] 'compare'  (duration: 53.118945ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:10:06.501933Z","caller":"traceutil/trace.go:171","msg":"trace[1076997425] range","detail":"{range_begin:/registry/events/default/instance.189e84df9bf4b68f; range_end:; response_count:1; response_revision:103; }","duration":"181.216265ms","start":"2026-03-20T10:10:06.320701Z","end":"2026-03-20T10:10:06.501918Z","steps":["trace[1076997425] 'agreement among raft nodes before linearized reading'  (duration: 180.974473ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:06.683707Z","caller":"traceutil/trace.go:171","msg":"trace[203791496] transaction","detail":"{read_only:false; response_revision:108; number_of_response:1; }","duration":"146.944912ms","start":"2026-03-20T10:10:06.536725Z","end":"2026-03-20T10:10:06.683669Z","steps":["trace[203791496] 'process raft request'  (duration: 80.697798ms)","trace[203791496] 'compare'  (duration: 66.075315ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:10:08.348669Z","caller":"traceutil/trace.go:171","msg":"trace[149588309] transaction","detail":"{read_only:false; response_revision:243; number_of_response:1; }","duration":"110.125501ms","start":"2026-03-20T10:10:08.238505Z","end":"2026-03-20T10:10:08.34863Z","steps":["trace[149588309] 'process raft request'  (duration: 52.631557ms)","trace[149588309] 'compare'  (duration: 57.336157ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:10:08.547438Z","caller":"traceutil/trace.go:171","msg":"trace[225694545] transaction","detail":"{read_only:false; response_revision:247; number_of_response:1; }","duration":"111.370952ms","start":"2026-03-20T10:10:08.436037Z","end":"2026-03-20T10:10:08.547408Z","steps":["trace[225694545] 'process raft request'  (duration: 111.32432ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:08.54773Z","caller":"traceutil/trace.go:171","msg":"trace[1703504039] transaction","detail":"{read_only:false; response_revision:246; number_of_response:1; }","duration":"167.331532ms","start":"2026-03-20T10:10:08.38038Z","end":"2026-03-20T10:10:08.547711Z","steps":["trace[1703504039] 'process raft request'  (duration: 92.010844ms)","trace[1703504039] 'compare'  (duration: 74.769861ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:10:09.800429Z","caller":"traceutil/trace.go:171","msg":"trace[1575497613] transaction","detail":"{read_only:false; response_revision:262; number_of_response:1; }","duration":"129.663255ms","start":"2026-03-20T10:10:09.670738Z","end":"2026-03-20T10:10:09.800401Z","steps":["trace[1575497613] 'process raft request'  (duration: 81.178581ms)","trace[1575497613] 'compare'  (duration: 48.104106ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:10:10.042535Z","caller":"traceutil/trace.go:171","msg":"trace[1810941437] transaction","detail":"{read_only:false; response_revision:272; number_of_response:1; }","duration":"146.256371ms","start":"2026-03-20T10:10:09.896236Z","end":"2026-03-20T10:10:10.042492Z","steps":["trace[1810941437] 'process raft request'  (duration: 92.911154ms)","trace[1810941437] 'compare'  (duration: 52.749449ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:10:10.364013Z","caller":"traceutil/trace.go:171","msg":"trace[1439259396] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"106.44133ms","start":"2026-03-20T10:10:10.257542Z","end":"2026-03-20T10:10:10.363984Z","steps":["trace[1439259396] 'process raft request'  (duration: 42.694376ms)","trace[1439259396] 'compare'  (duration: 63.499752ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:10:11.932256Z","caller":"traceutil/trace.go:171","msg":"trace[501553434] linearizableReadLoop","detail":"{readStateIndex:340; appliedIndex:339; }","duration":"130.49248ms","start":"2026-03-20T10:10:11.801727Z","end":"2026-03-20T10:10:11.93222Z","steps":["trace[501553434] 'read index received'  (duration: 105.873074ms)","trace[501553434] 'applied index is now lower than readState.Index'  (duration: 24.618096ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:10:11.932445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.684549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-03-20T10:10:11.932488Z","caller":"traceutil/trace.go:171","msg":"trace[1241871310] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:326; }","duration":"130.798384ms","start":"2026-03-20T10:10:11.801676Z","end":"2026-03-20T10:10:11.932474Z","steps":["trace[1241871310] 'agreement among raft nodes before linearized reading'  (duration: 130.684939ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:11.932576Z","caller":"traceutil/trace.go:171","msg":"trace[455143707] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"135.206271ms","start":"2026-03-20T10:10:11.797342Z","end":"2026-03-20T10:10:11.932549Z","steps":["trace[455143707] 'process raft request'  (duration: 110.366554ms)","trace[455143707] 'compare'  (duration: 24.366635ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:10:12.22613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.502412ms","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-03-20T10:10:12.226284Z","caller":"traceutil/trace.go:171","msg":"trace[348613488] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:328; }","duration":"161.6785ms","start":"2026-03-20T10:10:12.064562Z","end":"2026-03-20T10:10:12.226241Z","steps":["trace[348613488] 'range keys from in-memory index tree'  (duration: 161.315364ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:12.226142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.307408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-03-20T10:10:12.226411Z","caller":"traceutil/trace.go:171","msg":"trace[1903360515] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:328; }","duration":"171.629983ms","start":"2026-03-20T10:10:12.05475Z","end":"2026-03-20T10:10:12.22638Z","steps":["trace[1903360515] 'range keys from in-memory index tree'  (duration: 171.14441ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:12.380721Z","caller":"traceutil/trace.go:171","msg":"trace[645630480] transaction","detail":"{read_only:false; response_revision:330; number_of_response:1; }","duration":"149.631999ms","start":"2026-03-20T10:10:12.231055Z","end":"2026-03-20T10:10:12.380687Z","steps":["trace[645630480] 'process raft request'  (duration: 102.677625ms)","trace[645630480] 'compare'  (duration: 46.702083ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:10:12.566971Z","caller":"traceutil/trace.go:171","msg":"trace[174012518] linearizableReadLoop","detail":"{readStateIndex:345; appliedIndex:344; }","duration":"165.553681ms","start":"2026-03-20T10:10:12.401382Z","end":"2026-03-20T10:10:12.566936Z","steps":["trace[174012518] 'read index received'  (duration: 158.328885ms)","trace[174012518] 'applied index is now lower than readState.Index'  (duration: 7.223356ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:10:12.567145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.719428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-03-20T10:10:12.567188Z","caller":"traceutil/trace.go:171","msg":"trace[295477115] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:331; }","duration":"165.824794ms","start":"2026-03-20T10:10:12.40135Z","end":"2026-03-20T10:10:12.567175Z","steps":["trace[295477115] 'agreement among raft nodes before linearized reading'  (duration: 165.708618ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:12.567435Z","caller":"traceutil/trace.go:171","msg":"trace[1598149686] transaction","detail":"{read_only:false; response_revision:331; number_of_response:1; }","duration":"174.857263ms","start":"2026-03-20T10:10:12.392547Z","end":"2026-03-20T10:10:12.567404Z","steps":["trace[1598149686] 'process raft request'  (duration: 167.129413ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:12.947818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.424635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-03-20T10:10:12.947922Z","caller":"traceutil/trace.go:171","msg":"trace[964252606] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:334; }","duration":"145.601583ms","start":"2026-03-20T10:10:12.802298Z","end":"2026-03-20T10:10:12.9479Z","steps":["trace[964252606] 'range keys from in-memory index tree'  (duration: 145.297968ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:14.939516Z","caller":"traceutil/trace.go:171","msg":"trace[888693216] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"128.961761ms","start":"2026-03-20T10:10:14.810508Z","end":"2026-03-20T10:10:14.93947Z","steps":["trace[888693216] 'process raft request'  (duration: 128.71411ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:15.255827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.412016ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14360181556229863488 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/configmaps/kube-public/cluster-info\" mod_revision:270 > success:<request_put:<key:\"/registry/configmaps/kube-public/cluster-info\" value_size:2110 >> failure:<request_range:<key:\"/registry/configmaps/kube-public/cluster-info\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:10:15.255971Z","caller":"traceutil/trace.go:171","msg":"trace[1370263455] linearizableReadLoop","detail":"{readStateIndex:364; appliedIndex:362; }","duration":"304.558187ms","start":"2026-03-20T10:10:14.951392Z","end":"2026-03-20T10:10:15.25595Z","steps":["trace[1370263455] 'read index received'  (duration: 27.244583ms)","trace[1370263455] 'applied index is now lower than readState.Index'  (duration: 277.312073ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:10:15.256155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.763096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"}
{"level":"info","ts":"2026-03-20T10:10:15.256204Z","caller":"traceutil/trace.go:171","msg":"trace[704398496] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:350; }","duration":"304.826968ms","start":"2026-03-20T10:10:14.95136Z","end":"2026-03-20T10:10:15.256186Z","steps":["trace[704398496] 'agreement among raft nodes before linearized reading'  (duration: 304.691392ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:15.256244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:10:14.95135Z","time spent":"304.886192ms","remote":"127.0.0.1:38244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":233,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "}
{"level":"info","ts":"2026-03-20T10:10:15.256255Z","caller":"traceutil/trace.go:171","msg":"trace[2060369542] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"307.862666ms","start":"2026-03-20T10:10:14.94814Z","end":"2026-03-20T10:10:15.256003Z","steps":["trace[2060369542] 'process raft request'  (duration: 133.151427ms)","trace[2060369542] 'compare'  (duration: 174.28283ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:10:15.256824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:10:14.948122Z","time spent":"308.524187ms","remote":"127.0.0.1:38138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2163,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/configmaps/kube-public/cluster-info\" mod_revision:270 > success:<request_put:<key:\"/registry/configmaps/kube-public/cluster-info\" value_size:2110 >> failure:<request_range:<key:\"/registry/configmaps/kube-public/cluster-info\" > >"}
{"level":"info","ts":"2026-03-20T10:10:15.276691Z","caller":"traceutil/trace.go:171","msg":"trace[1460143683] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"293.66487ms","start":"2026-03-20T10:10:14.983004Z","end":"2026-03-20T10:10:15.276669Z","steps":["trace[1460143683] 'process raft request'  (duration: 293.421659ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:15.27738Z","caller":"traceutil/trace.go:171","msg":"trace[1695600625] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"293.568635ms","start":"2026-03-20T10:10:14.983751Z","end":"2026-03-20T10:10:15.27732Z","steps":["trace[1695600625] 'process raft request'  (duration: 292.856554ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:15.277599Z","caller":"traceutil/trace.go:171","msg":"trace[1867292372] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"292.54331ms","start":"2026-03-20T10:10:14.984797Z","end":"2026-03-20T10:10:15.277341Z","steps":["trace[1867292372] 'process raft request'  (duration: 292.357701ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:15.282137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.672756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"}
{"level":"info","ts":"2026-03-20T10:10:15.282193Z","caller":"traceutil/trace.go:171","msg":"trace[1473632844] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:355; }","duration":"129.786851ms","start":"2026-03-20T10:10:15.15239Z","end":"2026-03-20T10:10:15.282176Z","steps":["trace[1473632844] 'agreement among raft nodes before linearized reading'  (duration: 129.673745ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:15.282414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.32904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"}
{"level":"info","ts":"2026-03-20T10:10:15.282512Z","caller":"traceutil/trace.go:171","msg":"trace[96182233] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:355; }","duration":"280.489777ms","start":"2026-03-20T10:10:15.002006Z","end":"2026-03-20T10:10:15.282496Z","steps":["trace[96182233] 'agreement among raft nodes before linearized reading'  (duration: 280.32524ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:15.282477Z","caller":"traceutil/trace.go:171","msg":"trace[1710728884] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"105.792729ms","start":"2026-03-20T10:10:15.176613Z","end":"2026-03-20T10:10:15.282405Z","steps":["trace[1710728884] 'process raft request'  (duration: 105.077566ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:15.282661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.569288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"}
{"level":"info","ts":"2026-03-20T10:10:15.282695Z","caller":"traceutil/trace.go:171","msg":"trace[1053989193] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:355; }","duration":"229.776566ms","start":"2026-03-20T10:10:15.052909Z","end":"2026-03-20T10:10:15.282685Z","steps":["trace[1053989193] 'agreement among raft nodes before linearized reading'  (duration: 229.732904ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:15.282624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.623022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"}
{"level":"info","ts":"2026-03-20T10:10:15.282778Z","caller":"traceutil/trace.go:171","msg":"trace[1407491650] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:355; }","duration":"179.828592ms","start":"2026-03-20T10:10:15.102943Z","end":"2026-03-20T10:10:15.282771Z","steps":["trace[1407491650] 'agreement among raft nodes before linearized reading'  (duration: 179.649463ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:16.688936Z","caller":"traceutil/trace.go:171","msg":"trace[45257665] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"126.264477ms","start":"2026-03-20T10:10:16.562637Z","end":"2026-03-20T10:10:16.688901Z","steps":["trace[45257665] 'process raft request'  (duration: 109.289148ms)","trace[45257665] 'compare'  (duration: 16.816632ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:10:17.433001Z","caller":"traceutil/trace.go:171","msg":"trace[676845437] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"101.020844ms","start":"2026-03-20T10:10:17.331957Z","end":"2026-03-20T10:10:17.432978Z","steps":["trace[676845437] 'process raft request'  (duration: 100.866488ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:17.436293Z","caller":"traceutil/trace.go:171","msg":"trace[866782607] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"103.555347ms","start":"2026-03-20T10:10:17.33269Z","end":"2026-03-20T10:10:17.436245Z","steps":["trace[866782607] 'process raft request'  (duration: 103.18138ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:20.480919Z","caller":"traceutil/trace.go:171","msg":"trace[2077849062] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"102.368585ms","start":"2026-03-20T10:10:20.378523Z","end":"2026-03-20T10:10:20.480892Z","steps":["trace[2077849062] 'process raft request'  (duration: 102.205879ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:21.660229Z","caller":"traceutil/trace.go:171","msg":"trace[1505715964] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"131.290539ms","start":"2026-03-20T10:10:21.528902Z","end":"2026-03-20T10:10:21.660193Z","steps":["trace[1505715964] 'process raft request'  (duration: 118.385039ms)","trace[1505715964] 'compare'  (duration: 12.771213ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:10:33.765758Z","caller":"traceutil/trace.go:171","msg":"trace[114842076] linearizableReadLoop","detail":"{readStateIndex:492; appliedIndex:491; }","duration":"169.899551ms","start":"2026-03-20T10:10:33.595825Z","end":"2026-03-20T10:10:33.765725Z","steps":["trace[114842076] 'read index received'  (duration: 167.846562ms)","trace[114842076] 'applied index is now lower than readState.Index'  (duration: 2.051629ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:10:33.765913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.059166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-20T10:10:33.765953Z","caller":"traceutil/trace.go:171","msg":"trace[1446197971] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:472; }","duration":"170.1567ms","start":"2026-03-20T10:10:33.595786Z","end":"2026-03-20T10:10:33.765942Z","steps":["trace[1446197971] 'agreement among raft nodes before linearized reading'  (duration: 170.047396ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:37.900102Z","caller":"traceutil/trace.go:171","msg":"trace[1231493309] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"109.210018ms","start":"2026-03-20T10:10:37.790866Z","end":"2026-03-20T10:10:37.900076Z","steps":["trace[1231493309] 'process raft request'  (duration: 109.020861ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:37.903923Z","caller":"traceutil/trace.go:171","msg":"trace[1900847715] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"111.241362ms","start":"2026-03-20T10:10:37.792641Z","end":"2026-03-20T10:10:37.903882Z","steps":["trace[1900847715] 'process raft request'  (duration: 111.076847ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:39.562121Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14360181556229863804,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-20T10:10:39.654276Z","caller":"traceutil/trace.go:171","msg":"trace[353967360] linearizableReadLoop","detail":"{readStateIndex:542; appliedIndex:541; }","duration":"593.068385ms","start":"2026-03-20T10:10:39.061186Z","end":"2026-03-20T10:10:39.654255Z","steps":["trace[353967360] 'read index received'  (duration: 592.92972ms)","trace[353967360] 'applied index is now lower than readState.Index'  (duration: 137.335µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:10:39.65432Z","caller":"traceutil/trace.go:171","msg":"trace[1650403645] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"641.959484ms","start":"2026-03-20T10:10:39.012326Z","end":"2026-03-20T10:10:39.654286Z","steps":["trace[1650403645] 'process raft request'  (duration: 641.799337ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:39.654377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.178269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:10:39.654402Z","caller":"traceutil/trace.go:171","msg":"trace[1617510827] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:521; }","duration":"593.262712ms","start":"2026-03-20T10:10:39.06113Z","end":"2026-03-20T10:10:39.654392Z","steps":["trace[1617510827] 'agreement among raft nodes before linearized reading'  (duration: 593.20556ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:39.654421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:10:39.061111Z","time spent":"593.305794ms","remote":"127.0.0.1:38020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T10:10:39.654496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:10:39.012312Z","time spent":"642.069127ms","remote":"127.0.0.1:38206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4567,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:420 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4533 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-03-20T10:10:44.091774Z","caller":"traceutil/trace.go:171","msg":"trace[816857084] linearizableReadLoop","detail":"{readStateIndex:576; appliedIndex:574; }","duration":"129.645286ms","start":"2026-03-20T10:10:43.962108Z","end":"2026-03-20T10:10:44.091754Z","steps":["trace[816857084] 'read index received'  (duration: 10.252311ms)","trace[816857084] 'applied index is now lower than readState.Index'  (duration: 119.391685ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:10:44.092008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.866404ms","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-03-20T10:10:44.092084Z","caller":"traceutil/trace.go:171","msg":"trace[1311601697] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:554; }","duration":"129.987189ms","start":"2026-03-20T10:10:43.962077Z","end":"2026-03-20T10:10:44.092064Z","steps":["trace[1311601697] 'agreement among raft nodes before linearized reading'  (duration: 129.823794ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:44.092212Z","caller":"traceutil/trace.go:171","msg":"trace[491561176] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"162.66194ms","start":"2026-03-20T10:10:43.929539Z","end":"2026-03-20T10:10:44.092201Z","steps":["trace[491561176] 'process raft request'  (duration: 96.79706ms)","trace[491561176] 'compare'  (duration: 65.133324ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:10:46.400003Z","caller":"traceutil/trace.go:171","msg":"trace[1888579751] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"777.170548ms","start":"2026-03-20T10:10:45.622806Z","end":"2026-03-20T10:10:46.399976Z","steps":["trace[1888579751] 'process raft request'  (duration: 776.968491ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:46.400181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:10:45.622791Z","time spent":"777.297562ms","remote":"127.0.0.1:38220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-wk94r\" mod_revision:512 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-wk94r\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-wk94r\" > >"}
{"level":"info","ts":"2026-03-20T10:10:47.109413Z","caller":"traceutil/trace.go:171","msg":"trace[1085254690] linearizableReadLoop","detail":"{readStateIndex:583; appliedIndex:581; }","duration":"1.132873386s","start":"2026-03-20T10:10:45.97651Z","end":"2026-03-20T10:10:47.109384Z","steps":["trace[1085254690] 'read index received'  (duration: 423.328534ms)","trace[1085254690] 'applied index is now lower than readState.Index'  (duration: 709.543522ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:10:47.109609Z","caller":"traceutil/trace.go:171","msg":"trace[1489890750] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"1.332981416s","start":"2026-03-20T10:10:45.776564Z","end":"2026-03-20T10:10:47.109545Z","steps":["trace[1489890750] 'process raft request'  (duration: 1.33250523s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:47.109663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.049332019s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T10:10:47.109669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"997.265989ms","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-03-20T10:10:47.109742Z","caller":"traceutil/trace.go:171","msg":"trace[319185997] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:561; }","duration":"1.049488123s","start":"2026-03-20T10:10:46.060235Z","end":"2026-03-20T10:10:47.109723Z","steps":["trace[319185997] 'agreement among raft nodes before linearized reading'  (duration: 1.049328988s)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:47.10975Z","caller":"traceutil/trace.go:171","msg":"trace[216042525] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:561; }","duration":"997.436936ms","start":"2026-03-20T10:10:46.112295Z","end":"2026-03-20T10:10:47.109732Z","steps":["trace[216042525] 'agreement among raft nodes before linearized reading'  (duration: 997.28484ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:47.109784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:10:46.060213Z","time spent":"1.049565017s","remote":"127.0.0.1:38020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T10:10:47.109796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:10:46.11226Z","time spent":"997.526788ms","remote":"127.0.0.1:38288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-20T10:10:47.109853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:10:45.776539Z","time spent":"1.333193105s","remote":"127.0.0.1:38288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:477 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-03-20T10:10:47.110026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.133524528s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-20T10:10:47.110573Z","caller":"traceutil/trace.go:171","msg":"trace[797549959] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:561; }","duration":"1.134093167s","start":"2026-03-20T10:10:45.976449Z","end":"2026-03-20T10:10:47.110542Z","steps":["trace[797549959] 'agreement among raft nodes before linearized reading'  (duration: 1.133530338s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:47.110641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:10:45.976426Z","time spent":"1.134199712s","remote":"127.0.0.1:38288","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":"warn","ts":"2026-03-20T10:10:47.110814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.250455ms","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-03-20T10:10:47.110944Z","caller":"traceutil/trace.go:171","msg":"trace[1591618766] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:561; }","duration":"437.41326ms","start":"2026-03-20T10:10:46.673476Z","end":"2026-03-20T10:10:47.110889Z","steps":["trace[1591618766] 'agreement among raft nodes before linearized reading'  (duration: 436.323583ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:47.111002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:10:46.673458Z","time spent":"437.533685ms","remote":"127.0.0.1:38288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-20T10:10:47.111585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.014373606s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-03-20T10:10:47.111624Z","caller":"traceutil/trace.go:171","msg":"trace[1067627237] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:561; }","duration":"1.014442718s","start":"2026-03-20T10:10:46.097165Z","end":"2026-03-20T10:10:47.111608Z","steps":["trace[1067627237] 'agreement among raft nodes before linearized reading'  (duration: 1.012525773s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:47.111645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:10:46.097147Z","time spent":"1.014492851s","remote":"127.0.0.1:38288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-20T10:10:49.184736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:10:47.591759Z","time spent":"1.592967672s","remote":"127.0.0.1:58802","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-03-20T10:10:49.184803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.040852635s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.122\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-20T10:10:49.185124Z","caller":"traceutil/trace.go:171","msg":"trace[1589119709] range","detail":"{range_begin:/registry/masterleases/199.19.213.122; range_end:; response_count:1; response_revision:565; }","duration":"1.041228357s","start":"2026-03-20T10:10:48.14386Z","end":"2026-03-20T10:10:49.185089Z","steps":["trace[1589119709] 'range keys from in-memory index tree'  (duration: 1.040722701s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:49.18518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:10:48.143838Z","time spent":"1.041327471s","remote":"127.0.0.1:38066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.19.213.122\" "}
{"level":"warn","ts":"2026-03-20T10:10:49.185383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.365311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:10:49.186781Z","caller":"traceutil/trace.go:171","msg":"trace[826774705] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:565; }","duration":"124.83484ms","start":"2026-03-20T10:10:49.061886Z","end":"2026-03-20T10:10:49.186721Z","steps":["trace[826774705] 'range keys from in-memory index tree'  (duration: 122.451081ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:51.215463Z","caller":"traceutil/trace.go:171","msg":"trace[2068596415] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"154.719146ms","start":"2026-03-20T10:10:51.060721Z","end":"2026-03-20T10:10:51.21544Z","steps":["trace[2068596415] 'read index received'  (duration: 154.625933ms)","trace[2068596415] 'applied index is now lower than readState.Index'  (duration: 92.233µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:10:51.215619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.89563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:10:51.215607Z","caller":"traceutil/trace.go:171","msg":"trace[1303556848] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"335.468663ms","start":"2026-03-20T10:10:50.880091Z","end":"2026-03-20T10:10:51.215559Z","steps":["trace[1303556848] 'process raft request'  (duration: 335.227385ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:51.215655Z","caller":"traceutil/trace.go:171","msg":"trace[1821075536] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"154.996124ms","start":"2026-03-20T10:10:51.060648Z","end":"2026-03-20T10:10:51.215644Z","steps":["trace[1821075536] 'agreement among raft nodes before linearized reading'  (duration: 154.88974ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:51.215764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:10:50.880057Z","time spent":"335.623597ms","remote":"127.0.0.1:38082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" value_size:8170 >> failure:<>"}
{"level":"info","ts":"2026-03-20T10:10:51.22084Z","caller":"traceutil/trace.go:171","msg":"trace[546033855] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"142.765981ms","start":"2026-03-20T10:10:51.078039Z","end":"2026-03-20T10:10:51.220805Z","steps":["trace[546033855] 'process raft request'  (duration: 142.607965ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:54.029254Z","caller":"traceutil/trace.go:171","msg":"trace[396146596] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"146.873618ms","start":"2026-03-20T10:10:53.882353Z","end":"2026-03-20T10:10:54.029227Z","steps":["trace[396146596] 'process raft request'  (duration: 146.679051ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:12:21.657521Z","caller":"traceutil/trace.go:171","msg":"trace[419666265] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"373.90984ms","start":"2026-03-20T10:12:21.283586Z","end":"2026-03-20T10:12:21.657496Z","steps":["trace[419666265] 'process raft request'  (duration: 373.763917ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:12:21.657697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:12:21.283565Z","time spent":"374.032282ms","remote":"127.0.0.1:38288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1006 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-20T10:12:21.947236Z","caller":"traceutil/trace.go:171","msg":"trace[1171942642] linearizableReadLoop","detail":"{readStateIndex:1061; appliedIndex:1060; }","duration":"141.637621ms","start":"2026-03-20T10:12:21.805572Z","end":"2026-03-20T10:12:21.94721Z","steps":["trace[1171942642] 'read index received'  (duration: 141.432617ms)","trace[1171942642] 'applied index is now lower than readState.Index'  (duration: 203.744µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:12:21.947274Z","caller":"traceutil/trace.go:171","msg":"trace[1286750093] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"147.32514ms","start":"2026-03-20T10:12:21.799924Z","end":"2026-03-20T10:12:21.947249Z","steps":["trace[1286750093] 'process raft request'  (duration: 147.154427ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:12:21.947579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.825935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-20T10:12:21.947651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.292987ms","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-03-20T10:12:21.947746Z","caller":"traceutil/trace.go:171","msg":"trace[517550513] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1014; }","duration":"114.400409ms","start":"2026-03-20T10:12:21.833295Z","end":"2026-03-20T10:12:21.947695Z","steps":["trace[517550513] 'agreement among raft nodes before linearized reading'  (duration: 114.068141ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:12:21.947659Z","caller":"traceutil/trace.go:171","msg":"trace[1096576321] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1014; }","duration":"142.118412ms","start":"2026-03-20T10:12:21.805518Z","end":"2026-03-20T10:12:21.947637Z","steps":["trace[1096576321] 'agreement among raft nodes before linearized reading'  (duration: 141.819635ms)"],"step_count":1}