{"level":"warn","ts":"2026-02-03T10:21:40.641794Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-03T10:21:40.643539Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.95: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.95:2380","--initial-cluster=instance=https://199.19.213.95:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.95:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.95: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-02-03T10:21:40.643759Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-03T10:21:40.643823Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.95:2380"]} {"level":"info","ts":"2026-02-03T10:21:40.643905Z","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-02-03T10:21:40.644706Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.95:2379"]} {"level":"info","ts":"2026-02-03T10:21:40.645675Z","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":2,"max-cpu-available":2,"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.95:2380"],"listen-peer-urls":["https://199.19.213.95:2380"],"advertise-client-urls":["https://199.19.213.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.95: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-02-03T10:21:40.650976Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.910234ms"} {"level":"info","ts":"2026-02-03T10:21:40.671204Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"371c7c2e52231793","cluster-id":"c115742627eabb7c"} {"level":"info","ts":"2026-02-03T10:21:40.671319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 switched to configuration voters=()"} {"level":"info","ts":"2026-02-03T10:21:40.671355Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 became follower at term 0"} {"level":"info","ts":"2026-02-03T10:21:40.671442Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 371c7c2e52231793 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-03T10:21:40.671506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 became follower at term 1"} {"level":"info","ts":"2026-02-03T10:21:40.671559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 switched to configuration voters=(3971185509822306195)"} {"level":"warn","ts":"2026-02-03T10:21:40.679121Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-03T10:21:40.685762Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-03T10:21:40.687298Z","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-02-03T10:21:40.690503Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"371c7c2e52231793","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-03T10:21:40.690862Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"371c7c2e52231793","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-03T10:21:40.69103Z","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-02-03T10:21:40.691097Z","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-02-03T10:21:40.691124Z","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-02-03T10:21:40.691593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 switched to configuration voters=(3971185509822306195)"} {"level":"info","ts":"2026-02-03T10:21:40.691693Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c115742627eabb7c","local-member-id":"371c7c2e52231793","added-peer-id":"371c7c2e52231793","added-peer-peer-urls":["https://199.19.213.95:2380"]} {"level":"info","ts":"2026-02-03T10:21:40.698536Z","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-02-03T10:21:40.698913Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"371c7c2e52231793","initial-advertise-peer-urls":["https://199.19.213.95:2380"],"listen-peer-urls":["https://199.19.213.95:2380"],"advertise-client-urls":["https://199.19.213.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-03T10:21:40.699049Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.95:2380"} {"level":"info","ts":"2026-02-03T10:21:40.699777Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.95:2380"} {"level":"info","ts":"2026-02-03T10:21:40.69973Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-03T10:21:40.971887Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 is starting a new election at term 1"} {"level":"info","ts":"2026-02-03T10:21:40.972006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-03T10:21:40.972039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 received MsgPreVoteResp from 371c7c2e52231793 at term 1"} {"level":"info","ts":"2026-02-03T10:21:40.972084Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 became candidate at term 2"} {"level":"info","ts":"2026-02-03T10:21:40.972169Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 received MsgVoteResp from 371c7c2e52231793 at term 2"} {"level":"info","ts":"2026-02-03T10:21:40.972209Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 became leader at term 2"} {"level":"info","ts":"2026-02-03T10:21:40.972267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 371c7c2e52231793 elected leader 371c7c2e52231793 at term 2"} {"level":"info","ts":"2026-02-03T10:21:40.974091Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-03T10:21:40.975242Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"371c7c2e52231793","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.95:2379]}","request-path":"/0/members/371c7c2e52231793/attributes","cluster-id":"c115742627eabb7c","publish-timeout":"7s"} {"level":"info","ts":"2026-02-03T10:21:40.975288Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-03T10:21:40.975581Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-03T10:21:40.979792Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.95:2379"} {"level":"info","ts":"2026-02-03T10:21:40.98579Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-03T10:21:40.985854Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-03T10:21:40.986979Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c115742627eabb7c","local-member-id":"371c7c2e52231793","cluster-version":"3.5"} {"level":"info","ts":"2026-02-03T10:21:40.987088Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-03T10:21:40.987152Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-03T10:21:40.988132Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-02-03T10:22:05.142684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.0761ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-03T10:22:05.142806Z","caller":"traceutil/trace.go:171","msg":"trace[1732990470] linearizableReadLoop","detail":"{readStateIndex:480; appliedIndex:479; }","duration":"415.121004ms","start":"2026-02-03T10:22:04.727657Z","end":"2026-02-03T10:22:05.142778Z","steps":["trace[1732990470] 'read index received' (duration: 259.332669ms)","trace[1732990470] 'applied index is now lower than readState.Index' (duration: 155.787385ms)"],"step_count":2} {"level":"info","ts":"2026-02-03T10:22:05.143005Z","caller":"traceutil/trace.go:171","msg":"trace[1234607590] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"516.777672ms","start":"2026-02-03T10:22:04.626212Z","end":"2026-02-03T10:22:05.14299Z","steps":["trace[1234607590] 'process raft request' (duration: 360.822487ms)","trace[1234607590] 'compare' (duration: 154.969359ms)"],"step_count":2} {"level":"warn","ts":"2026-02-03T10:22:05.143099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T10:22:04.626196Z","time spent":"516.864023ms","remote":"127.0.0.1:57590","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-03T10:22:05.145703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.04073ms","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-02-03T10:22:05.145736Z","caller":"traceutil/trace.go:171","msg":"trace[1640858258] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:467; }","duration":"418.097761ms","start":"2026-02-03T10:22:04.727631Z","end":"2026-02-03T10:22:05.145728Z","steps":["trace[1640858258] 'agreement among raft nodes before linearized reading' (duration: 415.231335ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:22:05.14582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T10:22:04.727618Z","time spent":"418.193111ms","remote":"127.0.0.1:57802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-03T10:22:10.755578Z","caller":"traceutil/trace.go:171","msg":"trace[234899150] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"293.715284ms","start":"2026-02-03T10:22:10.461843Z","end":"2026-02-03T10:22:10.755559Z","steps":["trace[234899150] 'process raft request' (duration: 278.181551ms)","trace[234899150] 'compare' (duration: 15.430923ms)"],"step_count":2} {"level":"warn","ts":"2026-02-03T10:22:11.403968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.36701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4018"} {"level":"warn","ts":"2026-02-03T10:22:11.404011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.737887ms","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-02-03T10:22:11.404064Z","caller":"traceutil/trace.go:171","msg":"trace[202790529] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:514; }","duration":"116.501621ms","start":"2026-02-03T10:22:11.287542Z","end":"2026-02-03T10:22:11.404043Z","steps":["trace[202790529] 'range keys from in-memory index tree' (duration: 116.2942ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T10:22:11.404103Z","caller":"traceutil/trace.go:171","msg":"trace[1235185507] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:514; }","duration":"175.872578ms","start":"2026-02-03T10:22:11.228207Z","end":"2026-02-03T10:22:11.404079Z","steps":["trace[1235185507] 'range keys from in-memory index tree' (duration: 175.640546ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:22:11.404349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.897061ms","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-02-03T10:22:11.404379Z","caller":"traceutil/trace.go:171","msg":"trace[494390328] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:514; }","duration":"172.936971ms","start":"2026-02-03T10:22:11.231432Z","end":"2026-02-03T10:22:11.404369Z","steps":["trace[494390328] 'range keys from in-memory index tree' (duration: 172.851281ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:22:11.4044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.506778ms","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-02-03T10:22:11.404433Z","caller":"traceutil/trace.go:171","msg":"trace[1217462038] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:514; }","duration":"217.537358ms","start":"2026-02-03T10:22:11.186885Z","end":"2026-02-03T10:22:11.404422Z","steps":["trace[1217462038] 'range keys from in-memory index tree' (duration: 217.421148ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:22:11.404586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.745394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-03T10:22:11.404612Z","caller":"traceutil/trace.go:171","msg":"trace[69854705] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:514; }","duration":"154.786594ms","start":"2026-02-03T10:22:11.249818Z","end":"2026-02-03T10:22:11.404605Z","steps":["trace[69854705] 'range keys from in-memory index tree' (duration: 154.713034ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T10:22:11.655277Z","caller":"traceutil/trace.go:171","msg":"trace[867900866] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"244.833064ms","start":"2026-02-03T10:22:11.410423Z","end":"2026-02-03T10:22:11.655256Z","steps":["trace[867900866] 'process raft request' (duration: 244.692084ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T10:22:11.742831Z","caller":"traceutil/trace.go:171","msg":"trace[1033256674] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"328.601451ms","start":"2026-02-03T10:22:11.414204Z","end":"2026-02-03T10:22:11.742805Z","steps":["trace[1033256674] 'process raft request' (duration: 294.373168ms)","trace[1033256674] 'compare' (duration: 34.029582ms)"],"step_count":2} {"level":"warn","ts":"2026-02-03T10:22:11.742971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T10:22:11.41419Z","time spent":"328.711512ms","remote":"127.0.0.1:57802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-03T10:22:11.743448Z","caller":"traceutil/trace.go:171","msg":"trace[1111733517] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"329.183933ms","start":"2026-02-03T10:22:11.414252Z","end":"2026-02-03T10:22:11.743436Z","steps":["trace[1111733517] 'process raft request' (duration: 328.48526ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:22:11.743515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T10:22:11.414247Z","time spent":"329.234383ms","remote":"127.0.0.1:57802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-03T10:22:11.743467Z","caller":"traceutil/trace.go:171","msg":"trace[455320100] linearizableReadLoop","detail":"{readStateIndex:532; appliedIndex:529; }","duration":"325.401243ms","start":"2026-02-03T10:22:11.418045Z","end":"2026-02-03T10:22:11.743446Z","steps":["trace[455320100] 'read index received' (duration: 237.765127ms)","trace[455320100] 'applied index is now lower than readState.Index' (duration: 87.635186ms)"],"step_count":2} {"level":"info","ts":"2026-02-03T10:22:11.747274Z","caller":"traceutil/trace.go:171","msg":"trace[233576938] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"331.094634ms","start":"2026-02-03T10:22:11.416165Z","end":"2026-02-03T10:22:11.74726Z","steps":["trace[233576938] 'process raft request' (duration: 327.113112ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:22:11.747352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T10:22:11.416158Z","time spent":"331.156294ms","remote":"127.0.0.1:57720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4210,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-03T10:22:11.74987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.810957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-03T10:22:11.749953Z","caller":"traceutil/trace.go:171","msg":"trace[950486854] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:518; }","duration":"331.917258ms","start":"2026-02-03T10:22:11.418022Z","end":"2026-02-03T10:22:11.749939Z","steps":["trace[950486854] 'agreement among raft nodes before linearized reading' (duration: 328.45321ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:22:11.750016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T10:22:11.418014Z","time spent":"331.973158ms","remote":"127.0.0.1:57802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-03T10:22:13.524318Z","caller":"traceutil/trace.go:171","msg":"trace[1171601582] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"200.127623ms","start":"2026-02-03T10:22:13.323926Z","end":"2026-02-03T10:22:13.524054Z","steps":["trace[1171601582] 'process raft request' (duration: 200.017953ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:22:13.891739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.596593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-03T10:22:13.891822Z","caller":"traceutil/trace.go:171","msg":"trace[1735424469] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:520; }","duration":"129.724173ms","start":"2026-02-03T10:22:13.762079Z","end":"2026-02-03T10:22:13.891803Z","steps":["trace[1735424469] 'range keys from in-memory index tree' (duration: 129.412882ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:22:13.891832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.707656ms","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-02-03T10:22:13.891873Z","caller":"traceutil/trace.go:171","msg":"trace[1602588491] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:520; }","duration":"141.783946ms","start":"2026-02-03T10:22:13.750075Z","end":"2026-02-03T10:22:13.891859Z","steps":["trace[1602588491] 'range keys from in-memory index tree' (duration: 141.588835ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:22:13.891989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.682285ms","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-02-03T10:22:13.892007Z","caller":"traceutil/trace.go:171","msg":"trace[139432624] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:520; }","duration":"137.718115ms","start":"2026-02-03T10:22:13.754281Z","end":"2026-02-03T10:22:13.891999Z","steps":["trace[139432624] 'range keys from in-memory index tree' (duration: 137.598484ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:22:13.891756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.939087ms","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-02-03T10:22:13.892066Z","caller":"traceutil/trace.go:171","msg":"trace[1882960543] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:520; }","duration":"233.288468ms","start":"2026-02-03T10:22:13.658772Z","end":"2026-02-03T10:22:13.892061Z","steps":["trace[1882960543] 'range keys from in-memory index tree' (duration: 232.826076ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:22:20.08668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.448051ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-03T10:22:20.086789Z","caller":"traceutil/trace.go:171","msg":"trace[1464916039] linearizableReadLoop","detail":"{readStateIndex:578; appliedIndex:576; }","duration":"122.548871ms","start":"2026-02-03T10:22:19.964231Z","end":"2026-02-03T10:22:20.08678Z","steps":["trace[1464916039] 'read index received' (duration: 11.94621ms)","trace[1464916039] 'applied index is now lower than readState.Index' (duration: 110.602081ms)"],"step_count":2} {"level":"warn","ts":"2026-02-03T10:22:20.086874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.642432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-03T10:22:20.086888Z","caller":"traceutil/trace.go:171","msg":"trace[891616171] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:562; }","duration":"122.685262ms","start":"2026-02-03T10:22:19.964197Z","end":"2026-02-03T10:22:20.086882Z","steps":["trace[891616171] 'agreement among raft nodes before linearized reading' (duration: 122.607131ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T10:22:20.087104Z","caller":"traceutil/trace.go:171","msg":"trace[215603939] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"137.157437ms","start":"2026-02-03T10:22:19.949939Z","end":"2026-02-03T10:22:20.087097Z","steps":["trace[215603939] 'process raft request' (duration: 26.226573ms)","trace[215603939] 'compare' (duration: 110.36413ms)"],"step_count":2} {"level":"info","ts":"2026-02-03T10:22:20.087167Z","caller":"traceutil/trace.go:171","msg":"trace[172959971] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"136.449923ms","start":"2026-02-03T10:22:19.950713Z","end":"2026-02-03T10:22:20.087163Z","steps":["trace[172959971] 'process raft request' (duration: 136.04033ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T10:22:20.568527Z","caller":"traceutil/trace.go:171","msg":"trace[449951659] linearizableReadLoop","detail":"{readStateIndex:579; appliedIndex:578; }","duration":"312.495273ms","start":"2026-02-03T10:22:20.256012Z","end":"2026-02-03T10:22:20.568508Z","steps":["trace[449951659] 'read index received' (duration: 277.117494ms)","trace[449951659] 'applied index is now lower than readState.Index' (duration: 35.377059ms)"],"step_count":2} {"level":"info","ts":"2026-02-03T10:22:20.568654Z","caller":"traceutil/trace.go:171","msg":"trace[2114178377] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"476.299473ms","start":"2026-02-03T10:22:20.092346Z","end":"2026-02-03T10:22:20.568646Z","steps":["trace[2114178377] 'process raft request' (duration: 440.752313ms)","trace[2114178377] 'compare' (duration: 35.312128ms)"],"step_count":2} {"level":"warn","ts":"2026-02-03T10:22:20.56875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T10:22:20.092332Z","time spent":"476.342134ms","remote":"127.0.0.1:57802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-03T10:22:20.568973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.781499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8mx7j\" ","response":"range_response_count:1 size:16652"} {"level":"info","ts":"2026-02-03T10:22:20.569053Z","caller":"traceutil/trace.go:171","msg":"trace[2024029113] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8mx7j; range_end:; response_count:1; response_revision:563; }","duration":"226.906749ms","start":"2026-02-03T10:22:20.342113Z","end":"2026-02-03T10:22:20.56902Z","steps":["trace[2024029113] 'agreement among raft nodes before linearized reading' (duration: 226.723398ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:22:20.569092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.094076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-03T10:22:20.569137Z","caller":"traceutil/trace.go:171","msg":"trace[1478769148] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:563; }","duration":"313.161646ms","start":"2026-02-03T10:22:20.255968Z","end":"2026-02-03T10:22:20.56913Z","steps":["trace[1478769148] 'agreement among raft nodes before linearized reading' (duration: 313.100256ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:22:20.569158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T10:22:20.255954Z","time spent":"313.200106ms","remote":"127.0.0.1:57566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-03T10:22:20.776096Z","caller":"traceutil/trace.go:171","msg":"trace[1550063717] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"189.448481ms","start":"2026-02-03T10:22:20.586608Z","end":"2026-02-03T10:22:20.776056Z","steps":["trace[1550063717] 'process raft request' (duration: 156.648104ms)","trace[1550063717] 'compare' (duration: 32.627866ms)"],"step_count":2} {"level":"warn","ts":"2026-02-03T10:22:22.750244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.349165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-03T10:22:22.7503Z","caller":"traceutil/trace.go:171","msg":"trace[1645037604] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:564; }","duration":"176.446945ms","start":"2026-02-03T10:22:22.573841Z","end":"2026-02-03T10:22:22.750288Z","steps":["trace[1645037604] 'range keys from in-memory index tree' (duration: 175.969953ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:22:22.750432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.639749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-02-03T10:22:22.750512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.74102ms","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-02-03T10:22:22.750515Z","caller":"traceutil/trace.go:171","msg":"trace[994338471] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:564; }","duration":"800.76957ms","start":"2026-02-03T10:22:21.949721Z","end":"2026-02-03T10:22:22.75049Z","steps":["trace[994338471] 'range keys from in-memory index tree' (duration: 800.449248ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T10:22:22.750533Z","caller":"traceutil/trace.go:171","msg":"trace[680212042] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:564; }","duration":"659.78747ms","start":"2026-02-03T10:22:22.09074Z","end":"2026-02-03T10:22:22.750528Z","steps":["trace[680212042] 'range keys from in-memory index tree' (duration: 659.67549ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:22:22.750548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T10:22:22.090727Z","time spent":"659.81763ms","remote":"127.0.0.1:57802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-03T10:22:22.750559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T10:22:21.949703Z","time spent":"800.84697ms","remote":"127.0.0.1:57802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-03T10:22:22.750624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.999927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-03T10:22:22.750639Z","caller":"traceutil/trace.go:171","msg":"trace[303639078] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:564; }","duration":"659.041957ms","start":"2026-02-03T10:22:22.091591Z","end":"2026-02-03T10:22:22.750633Z","steps":["trace[303639078] 'range keys from in-memory index tree' (duration: 658.928996ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:22:22.750652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T10:22:22.091576Z","time spent":"659.073527ms","remote":"127.0.0.1:57802","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-02-03T10:22:22.750777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.096909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-03T10:22:22.750789Z","caller":"traceutil/trace.go:171","msg":"trace[681147996] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:564; }","duration":"500.137729ms","start":"2026-02-03T10:22:22.250648Z","end":"2026-02-03T10:22:22.750786Z","steps":["trace[681147996] 'range keys from in-memory index tree' (duration: 500.038829ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:22:22.7508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T10:22:22.25063Z","time spent":"500.166829ms","remote":"127.0.0.1:57566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-03T10:22:24.670058Z","caller":"traceutil/trace.go:171","msg":"trace[906091440] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:594; }","duration":"118.446899ms","start":"2026-02-03T10:22:24.551586Z","end":"2026-02-03T10:22:24.670033Z","steps":["trace[906091440] 'read index received' (duration: 46.18777ms)","trace[906091440] 'applied index is now lower than readState.Index' (duration: 72.257679ms)"],"step_count":2} {"level":"info","ts":"2026-02-03T10:22:24.670102Z","caller":"traceutil/trace.go:171","msg":"trace[1655072418] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"126.639591ms","start":"2026-02-03T10:22:24.543425Z","end":"2026-02-03T10:22:24.670065Z","steps":["trace[1655072418] 'process raft request' (duration: 54.388961ms)","trace[1655072418] 'compare' (duration: 72.070229ms)"],"step_count":2} {"level":"warn","ts":"2026-02-03T10:22:24.670226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.61624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-02-03T10:22:24.670259Z","caller":"traceutil/trace.go:171","msg":"trace[701778428] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:578; }","duration":"118.66784ms","start":"2026-02-03T10:22:24.551582Z","end":"2026-02-03T10:22:24.67025Z","steps":["trace[701778428] 'agreement among raft nodes before linearized reading' (duration: 118.54454ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:22:25.20721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.12401ms","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-02-03T10:22:25.207296Z","caller":"traceutil/trace.go:171","msg":"trace[247223093] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:578; }","duration":"411.252791ms","start":"2026-02-03T10:22:24.796023Z","end":"2026-02-03T10:22:25.207276Z","steps":["trace[247223093] 'range keys from in-memory index tree' (duration: 410.974659ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:22:25.207339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T10:22:24.796004Z","time spent":"411.324481ms","remote":"127.0.0.1:57802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-03T10:22:25.207707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.792712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-03T10:22:25.20776Z","caller":"traceutil/trace.go:171","msg":"trace[1652517423] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:578; }","duration":"407.867354ms","start":"2026-02-03T10:22:24.799879Z","end":"2026-02-03T10:22:25.207746Z","steps":["trace[1652517423] 'range keys from in-memory index tree' (duration: 407.645312ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:22:25.207784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T10:22:24.799872Z","time spent":"407.907104ms","remote":"127.0.0.1:57802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-03T10:22:25.207879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.957809ms","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-02-03T10:22:25.207893Z","caller":"traceutil/trace.go:171","msg":"trace[1944791672] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:578; }","duration":"402.981379ms","start":"2026-02-03T10:22:24.804905Z","end":"2026-02-03T10:22:25.207886Z","steps":["trace[1944791672] 'range keys from in-memory index tree' (duration: 402.907209ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:22:25.207904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T10:22:24.804899Z","time spent":"403.001909ms","remote":"127.0.0.1:57802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-03T10:22:25.20808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.356346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-03T10:22:25.208115Z","caller":"traceutil/trace.go:171","msg":"trace[610087416] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:578; }","duration":"402.401706ms","start":"2026-02-03T10:22:24.805703Z","end":"2026-02-03T10:22:25.208105Z","steps":["trace[610087416] 'range keys from in-memory index tree' (duration: 402.266976ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:22:25.208146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T10:22:24.805697Z","time spent":"402.442036ms","remote":"127.0.0.1:57802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-03T10:22:29.714697Z","caller":"traceutil/trace.go:171","msg":"trace[1033467017] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"145.145608ms","start":"2026-02-03T10:22:29.569533Z","end":"2026-02-03T10:22:29.714679Z","steps":["trace[1033467017] 'process raft request' (duration: 143.099537ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T10:22:29.727626Z","caller":"traceutil/trace.go:171","msg":"trace[1088381947] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"100.342799ms","start":"2026-02-03T10:22:29.627259Z","end":"2026-02-03T10:22:29.727601Z","steps":["trace[1088381947] 'process raft request' (duration: 100.085348ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T10:22:30.147016Z","caller":"traceutil/trace.go:171","msg":"trace[360940450] linearizableReadLoop","detail":"{readStateIndex:687; appliedIndex:686; }","duration":"134.029711ms","start":"2026-02-03T10:22:30.012941Z","end":"2026-02-03T10:22:30.146971Z","steps":["trace[360940450] 'read index received' (duration: 129.74677ms)","trace[360940450] 'applied index is now lower than readState.Index' (duration: 4.281291ms)"],"step_count":2} {"level":"warn","ts":"2026-02-03T10:22:30.147968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.010655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188252"} {"level":"info","ts":"2026-02-03T10:22:30.147998Z","caller":"traceutil/trace.go:171","msg":"trace[1012113361] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:668; }","duration":"135.073035ms","start":"2026-02-03T10:22:30.012913Z","end":"2026-02-03T10:22:30.147986Z","steps":["trace[1012113361] 'agreement among raft nodes before linearized reading' (duration: 134.145721ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T10:22:30.154451Z","caller":"traceutil/trace.go:171","msg":"trace[296373495] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"148.469741ms","start":"2026-02-03T10:22:30.005961Z","end":"2026-02-03T10:22:30.15443Z","steps":["trace[296373495] 'process raft request' (duration: 136.809854ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T10:22:35.690113Z","caller":"traceutil/trace.go:171","msg":"trace[718766575] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"114.713205ms","start":"2026-02-03T10:22:35.575385Z","end":"2026-02-03T10:22:35.690099Z","steps":["trace[718766575] 'process raft request' (duration: 114.684375ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T10:22:35.690314Z","caller":"traceutil/trace.go:171","msg":"trace[1185456611] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"115.715805ms","start":"2026-02-03T10:22:35.574573Z","end":"2026-02-03T10:22:35.690289Z","steps":["trace[1185456611] 'process raft request' (duration: 115.418052ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T10:23:34.260666Z","caller":"traceutil/trace.go:171","msg":"trace[429179634] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"145.554624ms","start":"2026-02-03T10:23:34.115094Z","end":"2026-02-03T10:23:34.260649Z","steps":["trace[429179634] 'process raft request' (duration: 102.913954ms)","trace[429179634] 'compare' (duration: 42.13216ms)"],"step_count":2} {"level":"info","ts":"2026-02-03T10:24:09.855679Z","caller":"traceutil/trace.go:171","msg":"trace[114860625] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"128.203611ms","start":"2026-02-03T10:24:09.727403Z","end":"2026-02-03T10:24:09.855607Z","steps":["trace[114860625] 'process raft request' (duration: 127.706443ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T10:24:10.263859Z","caller":"traceutil/trace.go:171","msg":"trace[1996156346] linearizableReadLoop","detail":"{readStateIndex:1108; appliedIndex:1107; }","duration":"104.580578ms","start":"2026-02-03T10:24:10.159265Z","end":"2026-02-03T10:24:10.263846Z","steps":["trace[1996156346] 'read index received' (duration: 92.234145ms)","trace[1996156346] 'applied index is now lower than readState.Index' (duration: 12.345893ms)"],"step_count":2} {"level":"info","ts":"2026-02-03T10:24:10.263923Z","caller":"traceutil/trace.go:171","msg":"trace[689171514] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"105.559713ms","start":"2026-02-03T10:24:10.158356Z","end":"2026-02-03T10:24:10.263916Z","steps":["trace[689171514] 'process raft request' (duration: 93.17547ms)","trace[689171514] 'compare' (duration: 12.24549ms)"],"step_count":2} {"level":"warn","ts":"2026-02-03T10:24:10.264088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.810401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kubeadm-config\" ","response":"range_response_count:1 size:999"} {"level":"info","ts":"2026-02-03T10:24:10.264109Z","caller":"traceutil/trace.go:171","msg":"trace[1603213665] range","detail":"{range_begin:/registry/configmaps/kube-system/kubeadm-config; range_end:; response_count:1; response_revision:1067; }","duration":"104.865642ms","start":"2026-02-03T10:24:10.159239Z","end":"2026-02-03T10:24:10.264104Z","steps":["trace[1603213665] 'agreement among raft nodes before linearized reading' (duration: 104.813391ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:24:10.264249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.550021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kubelet-config\" ","response":"range_response_count:1 size:1357"} {"level":"info","ts":"2026-02-03T10:24:10.264349Z","caller":"traceutil/trace.go:171","msg":"trace[16644700] range","detail":"{range_begin:/registry/configmaps/kube-system/kubelet-config; range_end:; response_count:1; response_revision:1067; }","duration":"103.660083ms","start":"2026-02-03T10:24:10.160664Z","end":"2026-02-03T10:24:10.264324Z","steps":["trace[16644700] 'agreement among raft nodes before linearized reading' (duration: 103.511981ms)"],"step_count":1}