{"level":"warn","ts":"2026-02-13T01:57:22.923745Z","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-13T01:57:22.923848Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.217: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://162.253.55.217:2380","--initial-cluster=instance=https://162.253.55.217:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.217:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.217: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-13T01:57:22.923932Z","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-13T01:57:22.923951Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.217:2380"]} {"level":"info","ts":"2026-02-13T01:57:22.92399Z","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-13T01:57:22.924851Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.217:2379"]} {"level":"info","ts":"2026-02-13T01:57:22.924947Z","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://162.253.55.217:2380"],"listen-peer-urls":["https://162.253.55.217:2380"],"advertise-client-urls":["https://162.253.55.217:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.217:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.217: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-13T01:57:22.928794Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.616ms"} {"level":"info","ts":"2026-02-13T01:57:22.946559Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f1e368e6818bd6f7","cluster-id":"289e52865b7eaeb1"} {"level":"info","ts":"2026-02-13T01:57:22.946638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 switched to configuration voters=()"} {"level":"info","ts":"2026-02-13T01:57:22.946672Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became follower at term 0"} {"level":"info","ts":"2026-02-13T01:57:22.946696Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f1e368e6818bd6f7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-13T01:57:22.946707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became follower at term 1"} {"level":"info","ts":"2026-02-13T01:57:22.946744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 switched to configuration voters=(17429890322079143671)"} {"level":"warn","ts":"2026-02-13T01:57:22.960394Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-13T01:57:22.966248Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-13T01:57:22.969958Z","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-13T01:57:22.972518Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f1e368e6818bd6f7","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-13T01:57:22.979466Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f1e368e6818bd6f7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-13T01:57:22.983539Z","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-13T01:57:22.983575Z","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-13T01:57:22.983583Z","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-13T01:57:22.983853Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 switched to configuration voters=(17429890322079143671)"} {"level":"info","ts":"2026-02-13T01:57:22.983934Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"289e52865b7eaeb1","local-member-id":"f1e368e6818bd6f7","added-peer-id":"f1e368e6818bd6f7","added-peer-peer-urls":["https://162.253.55.217:2380"]} {"level":"info","ts":"2026-02-13T01:57:22.984056Z","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-13T01:57:22.984272Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.217:2380"} {"level":"info","ts":"2026-02-13T01:57:22.984289Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.217:2380"} {"level":"info","ts":"2026-02-13T01:57:22.984395Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f1e368e6818bd6f7","initial-advertise-peer-urls":["https://162.253.55.217:2380"],"listen-peer-urls":["https://162.253.55.217:2380"],"advertise-client-urls":["https://162.253.55.217:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.217:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-13T01:57:22.984415Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-13T01:57:23.747859Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 is starting a new election at term 1"} {"level":"info","ts":"2026-02-13T01:57:23.7479Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-13T01:57:23.747927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 received MsgPreVoteResp from f1e368e6818bd6f7 at term 1"} {"level":"info","ts":"2026-02-13T01:57:23.747938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became candidate at term 2"} {"level":"info","ts":"2026-02-13T01:57:23.748038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 received MsgVoteResp from f1e368e6818bd6f7 at term 2"} {"level":"info","ts":"2026-02-13T01:57:23.74805Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became leader at term 2"} {"level":"info","ts":"2026-02-13T01:57:23.74808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f1e368e6818bd6f7 elected leader f1e368e6818bd6f7 at term 2"} {"level":"info","ts":"2026-02-13T01:57:23.750886Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-13T01:57:23.751665Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f1e368e6818bd6f7","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.217:2379]}","request-path":"/0/members/f1e368e6818bd6f7/attributes","cluster-id":"289e52865b7eaeb1","publish-timeout":"7s"} {"level":"info","ts":"2026-02-13T01:57:23.75246Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-13T01:57:23.752769Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-13T01:57:23.754205Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"289e52865b7eaeb1","local-member-id":"f1e368e6818bd6f7","cluster-version":"3.5"} {"level":"info","ts":"2026-02-13T01:57:23.754383Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-13T01:57:23.754409Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-13T01:57:23.76153Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-13T01:57:23.762798Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.217:2379"} {"level":"info","ts":"2026-02-13T01:57:23.767596Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-13T01:57:23.767614Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-13T01:57:37.590452Z","caller":"traceutil/trace.go:171","msg":"trace[1099057693] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"117.625382ms","start":"2026-02-13T01:57:37.472811Z","end":"2026-02-13T01:57:37.590436Z","steps":["trace[1099057693] 'process raft request' (duration: 117.536901ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T01:57:37.93479Z","caller":"traceutil/trace.go:171","msg":"trace[471323833] linearizableReadLoop","detail":"{readStateIndex:381; appliedIndex:380; }","duration":"200.221079ms","start":"2026-02-13T01:57:37.734532Z","end":"2026-02-13T01:57:37.934753Z","steps":["trace[471323833] 'read index received' (duration: 200.044759ms)","trace[471323833] 'applied index is now lower than readState.Index' (duration: 175.6µs)"],"step_count":2} {"level":"info","ts":"2026-02-13T01:57:37.935207Z","caller":"traceutil/trace.go:171","msg":"trace[2000823036] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"254.755802ms","start":"2026-02-13T01:57:37.680438Z","end":"2026-02-13T01:57:37.935194Z","steps":["trace[2000823036] 'process raft request' (duration: 254.19088ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:57:37.935638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.086052ms","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-13T01:57:37.935692Z","caller":"traceutil/trace.go:171","msg":"trace[357345023] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:371; }","duration":"201.179442ms","start":"2026-02-13T01:57:37.734502Z","end":"2026-02-13T01:57:37.935681Z","steps":["trace[357345023] 'agreement among raft nodes before linearized reading' (duration: 201.082432ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:57:37.936124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.085012ms","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-13T01:57:37.936183Z","caller":"traceutil/trace.go:171","msg":"trace[384397975] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:371; }","duration":"198.164312ms","start":"2026-02-13T01:57:37.738008Z","end":"2026-02-13T01:57:37.936172Z","steps":["trace[384397975] 'agreement among raft nodes before linearized reading' (duration: 198.079762ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:57:38.466835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.057279ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T01:57:38.467601Z","caller":"traceutil/trace.go:171","msg":"trace[134478697] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"522.827204ms","start":"2026-02-13T01:57:37.944756Z","end":"2026-02-13T01:57:38.467583Z","steps":["trace[134478697] 'process raft request' (duration: 267.518581ms)","trace[134478697] 'compare' (duration: 253.926159ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T01:57:38.467683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:57:37.944738Z","time spent":"522.907854ms","remote":"127.0.0.1:58866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T01:57:38.46794Z","caller":"traceutil/trace.go:171","msg":"trace[131103346] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"520.326256ms","start":"2026-02-13T01:57:37.947591Z","end":"2026-02-13T01:57:38.467917Z","steps":["trace[131103346] 'process raft request' (duration: 519.335614ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:57:38.467992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:57:37.947574Z","time spent":"520.389416ms","remote":"127.0.0.1:58866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T01:57:38.468097Z","caller":"traceutil/trace.go:171","msg":"trace[285460236] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"517.844579ms","start":"2026-02-13T01:57:37.950245Z","end":"2026-02-13T01:57:38.468089Z","steps":["trace[285460236] 'process raft request' (duration: 517.228237ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:57:38.46814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:57:37.950229Z","time spent":"517.887969ms","remote":"127.0.0.1:58866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T01:57:38.66744Z","caller":"traceutil/trace.go:171","msg":"trace[415121027] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"185.553975ms","start":"2026-02-13T01:57:38.481865Z","end":"2026-02-13T01:57:38.667419Z","steps":["trace[415121027] 'process raft request' (duration: 93.93423ms)","trace[415121027] 'compare' (duration: 91.491924ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T01:57:40.818283Z","caller":"traceutil/trace.go:171","msg":"trace[1353561261] linearizableReadLoop","detail":"{readStateIndex:389; appliedIndex:388; }","duration":"343.480017ms","start":"2026-02-13T01:57:40.474781Z","end":"2026-02-13T01:57:40.818261Z","steps":["trace[1353561261] 'read index received' (duration: 343.338857ms)","trace[1353561261] 'applied index is now lower than readState.Index' (duration: 140.28µs)"],"step_count":2} {"level":"info","ts":"2026-02-13T01:57:40.818394Z","caller":"traceutil/trace.go:171","msg":"trace[962883160] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"391.377721ms","start":"2026-02-13T01:57:40.427008Z","end":"2026-02-13T01:57:40.818385Z","steps":["trace[962883160] 'process raft request' (duration: 391.12286ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:57:40.818608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:57:40.426996Z","time spent":"391.423011ms","remote":"127.0.0.1:59060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4158,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T01:57:40.818928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.300863ms","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-13T01:57:40.819944Z","caller":"traceutil/trace.go:171","msg":"trace[493329481] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:379; }","duration":"343.233207ms","start":"2026-02-13T01:57:40.476587Z","end":"2026-02-13T01:57:40.81982Z","steps":["trace[493329481] 'agreement among raft nodes before linearized reading' (duration: 342.291803ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:57:40.820208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:57:40.476554Z","time spent":"343.605208ms","remote":"127.0.0.1:58866","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-13T01:57:40.818994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.212809ms","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-02-13T01:57:40.82059Z","caller":"traceutil/trace.go:171","msg":"trace[2106653508] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:379; }","duration":"345.824105ms","start":"2026-02-13T01:57:40.474754Z","end":"2026-02-13T01:57:40.820578Z","steps":["trace[2106653508] 'agreement among raft nodes before linearized reading' (duration: 344.207779ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:57:40.82095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:57:40.474742Z","time spent":"346.178275ms","remote":"127.0.0.1:58866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-13T01:57:40.819019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.04341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T01:57:40.821315Z","caller":"traceutil/trace.go:171","msg":"trace[343722255] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:379; }","duration":"189.328887ms","start":"2026-02-13T01:57:40.631972Z","end":"2026-02-13T01:57:40.821301Z","steps":["trace[343722255] 'agreement among raft nodes before linearized reading' (duration: 187.03668ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:57:40.819045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.056396ms","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-13T01:57:40.824104Z","caller":"traceutil/trace.go:171","msg":"trace[2007770246] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:379; }","duration":"328.125322ms","start":"2026-02-13T01:57:40.495964Z","end":"2026-02-13T01:57:40.82409Z","steps":["trace[2007770246] 'agreement among raft nodes before linearized reading' (duration: 323.063646ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:57:40.824243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:57:40.495953Z","time spent":"328.258592ms","remote":"127.0.0.1:58866","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-13T01:57:40.819066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.10019ms","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-13T01:57:40.824581Z","caller":"traceutil/trace.go:171","msg":"trace[1684646063] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:379; }","duration":"346.640136ms","start":"2026-02-13T01:57:40.477933Z","end":"2026-02-13T01:57:40.824573Z","steps":["trace[1684646063] 'agreement among raft nodes before linearized reading' (duration: 341.12094ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:57:40.82466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:57:40.477916Z","time spent":"346.733957ms","remote":"127.0.0.1:58866","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-13T01:57:54.153429Z","caller":"traceutil/trace.go:171","msg":"trace[946119379] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"510.131685ms","start":"2026-02-13T01:57:53.643275Z","end":"2026-02-13T01:57:54.153407Z","steps":["trace[946119379] 'process raft request' (duration: 510.010045ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:57:54.153571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:57:53.643263Z","time spent":"510.239175ms","remote":"127.0.0.1:58766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4211,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T01:57:56.977056Z","caller":"traceutil/trace.go:171","msg":"trace[1016126212] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"124.869472ms","start":"2026-02-13T01:57:56.852162Z","end":"2026-02-13T01:57:56.977032Z","steps":["trace[1016126212] 'process raft request' (duration: 81.364433ms)","trace[1016126212] 'compare' (duration: 43.339429ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T01:57:56.977223Z","caller":"traceutil/trace.go:171","msg":"trace[165015004] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"124.872293ms","start":"2026-02-13T01:57:56.852336Z","end":"2026-02-13T01:57:56.977209Z","steps":["trace[165015004] 'process raft request' (duration: 124.660672ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T01:57:56.977432Z","caller":"traceutil/trace.go:171","msg":"trace[119816207] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"122.739785ms","start":"2026-02-13T01:57:56.854675Z","end":"2026-02-13T01:57:56.977415Z","steps":["trace[119816207] 'process raft request' (duration: 122.355714ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T01:57:57.109833Z","caller":"traceutil/trace.go:171","msg":"trace[639062133] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"117.916983ms","start":"2026-02-13T01:57:56.991879Z","end":"2026-02-13T01:57:57.109795Z","steps":["trace[639062133] 'process raft request' (duration: 117.886673ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T01:57:57.109864Z","caller":"traceutil/trace.go:171","msg":"trace[1350473432] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"120.789971ms","start":"2026-02-13T01:57:56.989059Z","end":"2026-02-13T01:57:57.109849Z","steps":["trace[1350473432] 'process raft request' (duration: 120.49384ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T01:57:57.11001Z","caller":"traceutil/trace.go:171","msg":"trace[1312544943] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"126.142338ms","start":"2026-02-13T01:57:56.983862Z","end":"2026-02-13T01:57:57.110004Z","steps":["trace[1312544943] 'process raft request' (duration: 109.550088ms)","trace[1312544943] 'compare' (duration: 15.972988ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T01:57:57.110065Z","caller":"traceutil/trace.go:171","msg":"trace[1812218649] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"123.6836ms","start":"2026-02-13T01:57:56.986377Z","end":"2026-02-13T01:57:57.110061Z","steps":["trace[1812218649] 'process raft request' (duration: 123.146358ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T01:57:57.110118Z","caller":"traceutil/trace.go:171","msg":"trace[2044931487] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"120.33686ms","start":"2026-02-13T01:57:56.989774Z","end":"2026-02-13T01:57:57.11011Z","steps":["trace[2044931487] 'process raft request' (duration: 119.815968ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T01:57:57.110263Z","caller":"traceutil/trace.go:171","msg":"trace[1206116648] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"119.449027ms","start":"2026-02-13T01:57:56.990808Z","end":"2026-02-13T01:57:57.110257Z","steps":["trace[1206116648] 'process raft request' (duration: 118.879036ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T01:57:57.423508Z","caller":"traceutil/trace.go:171","msg":"trace[4482699] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"156.720668ms","start":"2026-02-13T01:57:57.266734Z","end":"2026-02-13T01:57:57.423454Z","steps":["trace[4482699] 'process raft request' (duration: 91.760984ms)","trace[4482699] 'compare' (duration: 64.791994ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T01:57:57.540723Z","caller":"traceutil/trace.go:171","msg":"trace[746080078] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"110.328269ms","start":"2026-02-13T01:57:57.430376Z","end":"2026-02-13T01:57:57.540704Z","steps":["trace[746080078] 'process raft request' (duration: 110.006548ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T01:57:59.329406Z","caller":"traceutil/trace.go:171","msg":"trace[1106655593] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"209.898057ms","start":"2026-02-13T01:57:59.119489Z","end":"2026-02-13T01:57:59.329387Z","steps":["trace[1106655593] 'process raft request' (duration: 209.795227ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T01:57:59.440282Z","caller":"traceutil/trace.go:171","msg":"trace[95793105] linearizableReadLoop","detail":"{readStateIndex:522; appliedIndex:521; }","duration":"319.514385ms","start":"2026-02-13T01:57:59.12075Z","end":"2026-02-13T01:57:59.440264Z","steps":["trace[95793105] 'read index received' (duration: 209.009954ms)","trace[95793105] 'applied index is now lower than readState.Index' (duration: 110.503721ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T01:57:59.440546Z","caller":"traceutil/trace.go:171","msg":"trace[2033436134] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"320.486158ms","start":"2026-02-13T01:57:59.120048Z","end":"2026-02-13T01:57:59.440535Z","steps":["trace[2033436134] 'process raft request' (duration: 310.144117ms)","trace[2033436134] 'compare' (duration: 10.007221ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T01:57:59.440648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:57:59.119252Z","time spent":"321.331211ms","remote":"127.0.0.1:58866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T01:57:59.440878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.121966ms","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-13T01:57:59.440917Z","caller":"traceutil/trace.go:171","msg":"trace[310411848] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:507; }","duration":"320.172286ms","start":"2026-02-13T01:57:59.120734Z","end":"2026-02-13T01:57:59.440906Z","steps":["trace[310411848] 'agreement among raft nodes before linearized reading' (duration: 320.043066ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:57:59.440951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:57:59.120727Z","time spent":"320.216957ms","remote":"127.0.0.1:58866","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-02-13T01:57:59.441118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.697135ms","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-13T01:57:59.441151Z","caller":"traceutil/trace.go:171","msg":"trace[902134909] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:507; }","duration":"319.741365ms","start":"2026-02-13T01:57:59.121402Z","end":"2026-02-13T01:57:59.441143Z","steps":["trace[902134909] 'agreement among raft nodes before linearized reading' (duration: 319.662945ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:57:59.441176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:57:59.121395Z","time spent":"319.775135ms","remote":"127.0.0.1:58866","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":"info","ts":"2026-02-13T01:58:03.774197Z","caller":"traceutil/trace.go:171","msg":"trace[418739923] linearizableReadLoop","detail":"{readStateIndex:534; appliedIndex:533; }","duration":"427.105147ms","start":"2026-02-13T01:58:03.347079Z","end":"2026-02-13T01:58:03.774185Z","steps":["trace[418739923] 'read index received' (duration: 426.983797ms)","trace[418739923] 'applied index is now lower than readState.Index' (duration: 120.87µs)"],"step_count":2} {"level":"info","ts":"2026-02-13T01:58:03.774392Z","caller":"traceutil/trace.go:171","msg":"trace[1152692052] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"1.034272971s","start":"2026-02-13T01:58:02.740113Z","end":"2026-02-13T01:58:03.774386Z","steps":["trace[1152692052] 'process raft request' (duration: 1.033992491s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:03.774453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:58:02.740103Z","time spent":"1.034307922s","remote":"127.0.0.1:58774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T01:58:03.774589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.510058ms","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-02-13T01:58:03.774609Z","caller":"traceutil/trace.go:171","msg":"trace[1796872667] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:518; }","duration":"427.562768ms","start":"2026-02-13T01:58:03.347041Z","end":"2026-02-13T01:58:03.774604Z","steps":["trace[1796872667] 'agreement among raft nodes before linearized reading' (duration: 427.498608ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:03.774628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:58:03.347022Z","time spent":"427.602158ms","remote":"127.0.0.1:58866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-13T01:58:03.774724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.7686ms","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-13T01:58:03.77474Z","caller":"traceutil/trace.go:171","msg":"trace[1316669783] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:518; }","duration":"324.80949ms","start":"2026-02-13T01:58:03.449927Z","end":"2026-02-13T01:58:03.774737Z","steps":["trace[1316669783] 'agreement among raft nodes before linearized reading' (duration: 324.76923ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:03.774753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:58:03.449914Z","time spent":"324.83626ms","remote":"127.0.0.1:58866","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-13T01:58:03.77488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.565553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T01:58:03.774897Z","caller":"traceutil/trace.go:171","msg":"trace[944908295] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:518; }","duration":"144.605513ms","start":"2026-02-13T01:58:03.630288Z","end":"2026-02-13T01:58:03.774893Z","steps":["trace[944908295] 'agreement among raft nodes before linearized reading' (duration: 144.580573ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:03.774995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.268602ms","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-13T01:58:03.775011Z","caller":"traceutil/trace.go:171","msg":"trace[1968049418] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:518; }","duration":"295.295812ms","start":"2026-02-13T01:58:03.479712Z","end":"2026-02-13T01:58:03.775008Z","steps":["trace[1968049418] 'agreement among raft nodes before linearized reading' (duration: 295.238952ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:03.775083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.021585ms","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-13T01:58:03.775098Z","caller":"traceutil/trace.go:171","msg":"trace[758866755] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:518; }","duration":"296.047185ms","start":"2026-02-13T01:58:03.479048Z","end":"2026-02-13T01:58:03.775095Z","steps":["trace[758866755] 'agreement among raft nodes before linearized reading' (duration: 296.012245ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:03.954492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.142507ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T01:58:03.954559Z","caller":"traceutil/trace.go:171","msg":"trace[656879495] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"172.341534ms","start":"2026-02-13T01:58:03.782207Z","end":"2026-02-13T01:58:03.954548Z","steps":["trace[656879495] 'process raft request' (duration: 66.088337ms)","trace[656879495] 'compare' (duration: 106.060097ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T01:58:05.57275Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.699397039s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-13T01:58:06.062262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.306122ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T01:58:06.062406Z","caller":"traceutil/trace.go:171","msg":"trace[2127237787] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:535; }","duration":"431.086518ms","start":"2026-02-13T01:58:05.631305Z","end":"2026-02-13T01:58:06.062392Z","steps":["trace[2127237787] 'read index received' (duration: 25.99µs)","trace[2127237787] 'applied index is now lower than readState.Index' (duration: 431.059788ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T01:58:06.062577Z","caller":"traceutil/trace.go:171","msg":"trace[776860970] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"2.280143214s","start":"2026-02-13T01:58:03.782424Z","end":"2026-02-13T01:58:06.062567Z","steps":["trace[776860970] 'process raft request' (duration: 1.7904665s)","trace[776860970] 'compare' (duration: 488.947411ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T01:58:06.062639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:58:03.782418Z","time spent":"2.280179074s","remote":"127.0.0.1:58866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T01:58:06.06276Z","caller":"traceutil/trace.go:171","msg":"trace[779408768] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"2.280284874s","start":"2026-02-13T01:58:03.782469Z","end":"2026-02-13T01:58:06.062753Z","steps":["trace[779408768] 'process raft request' (duration: 2.279862682s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:06.062797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:58:03.782464Z","time spent":"2.280314134s","remote":"127.0.0.1:58866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T01:58:06.06288Z","caller":"traceutil/trace.go:171","msg":"trace[746938084] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"2.278927231s","start":"2026-02-13T01:58:03.783946Z","end":"2026-02-13T01:58:06.062873Z","steps":["trace[746938084] 'process raft request' (duration: 2.278419659s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:06.062913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:58:03.783938Z","time spent":"2.278955592s","remote":"127.0.0.1:58866","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-13T01:58:06.063327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.017011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T01:58:06.063357Z","caller":"traceutil/trace.go:171","msg":"trace[1932961638] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:522; }","duration":"432.047731ms","start":"2026-02-13T01:58:05.631301Z","end":"2026-02-13T01:58:06.063349Z","steps":["trace[1932961638] 'agreement among raft nodes before linearized reading' (duration: 431.996571ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:06.063379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:58:05.631262Z","time spent":"432.113621ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-13T01:58:06.063539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.189918ms","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-02-13T01:58:06.063559Z","caller":"traceutil/trace.go:171","msg":"trace[1480843202] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:522; }","duration":"106.232178ms","start":"2026-02-13T01:58:05.95732Z","end":"2026-02-13T01:58:06.063552Z","steps":["trace[1480843202] 'agreement among raft nodes before linearized reading' (duration: 106.151477ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T01:58:06.303561Z","caller":"traceutil/trace.go:171","msg":"trace[1840303497] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"230.554629ms","start":"2026-02-13T01:58:06.072989Z","end":"2026-02-13T01:58:06.303544Z","steps":["trace[1840303497] 'process raft request' (duration: 210.71261ms)","trace[1840303497] 'compare' (duration: 19.616679ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T01:58:07.940844Z","caller":"traceutil/trace.go:171","msg":"trace[430763156] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"177.890701ms","start":"2026-02-13T01:58:07.758345Z","end":"2026-02-13T01:58:07.936236Z","steps":["trace[430763156] 'process raft request' (duration: 173.139428ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:08.795237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.843327ms","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-02-13T01:58:08.795296Z","caller":"traceutil/trace.go:171","msg":"trace[1627487846] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:536; }","duration":"487.942127ms","start":"2026-02-13T01:58:08.30734Z","end":"2026-02-13T01:58:08.795282Z","steps":["trace[1627487846] 'range keys from in-memory index tree' (duration: 487.714637ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:08.795286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.309018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-13T01:58:08.795321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:58:08.307321Z","time spent":"487.995509ms","remote":"127.0.0.1:58866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-13T01:58:08.795331Z","caller":"traceutil/trace.go:171","msg":"trace[818557306] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:536; }","duration":"160.367499ms","start":"2026-02-13T01:58:08.634952Z","end":"2026-02-13T01:58:08.79532Z","steps":["trace[818557306] 'range keys from in-memory index tree' (duration: 160.200008ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:11.178688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.126283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"info","ts":"2026-02-13T01:58:11.178746Z","caller":"traceutil/trace.go:171","msg":"trace[1776115354] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:582; }","duration":"155.212163ms","start":"2026-02-13T01:58:11.023515Z","end":"2026-02-13T01:58:11.178728Z","steps":["trace[1776115354] 'range keys from in-memory index tree' (duration: 155.000103ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T01:58:12.525162Z","caller":"traceutil/trace.go:171","msg":"trace[954804213] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:616; }","duration":"100.000509ms","start":"2026-02-13T01:58:12.425139Z","end":"2026-02-13T01:58:12.52514Z","steps":["trace[954804213] 'read index received' (duration: 99.453137ms)","trace[954804213] 'applied index is now lower than readState.Index' (duration: 546.532µs)"],"step_count":2} {"level":"warn","ts":"2026-02-13T01:58:12.525373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.21ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-02-13T01:58:12.525411Z","caller":"traceutil/trace.go:171","msg":"trace[974702497] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:598; }","duration":"100.28908ms","start":"2026-02-13T01:58:12.425111Z","end":"2026-02-13T01:58:12.5254Z","steps":["trace[974702497] 'agreement among raft nodes before linearized reading' (duration: 100.114339ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T01:58:12.526097Z","caller":"traceutil/trace.go:171","msg":"trace[176412889] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"110.619972ms","start":"2026-02-13T01:58:12.41547Z","end":"2026-02-13T01:58:12.52609Z","steps":["trace[176412889] 'process raft request' (duration: 109.307797ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:12.90904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.455284ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T01:58:12.910063Z","caller":"traceutil/trace.go:171","msg":"trace[290275280] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"316.377285ms","start":"2026-02-13T01:58:12.593672Z","end":"2026-02-13T01:58:12.910049Z","steps":["trace[290275280] 'process raft request' (duration: 156.850948ms)","trace[290275280] 'compare' (duration: 158.252963ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T01:58:12.910141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:58:12.593655Z","time spent":"316.465855ms","remote":"127.0.0.1:58652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188237,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T01:58:12.910529Z","caller":"traceutil/trace.go:171","msg":"trace[1737715777] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:617; }","duration":"124.625782ms","start":"2026-02-13T01:58:12.785897Z","end":"2026-02-13T01:58:12.910522Z","steps":["trace[1737715777] 'read index received' (duration: 123.126338ms)","trace[1737715777] 'applied index is now lower than readState.Index' (duration: 1.499054ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T01:58:12.911354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.458805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-c8h9s\" ","response":"range_response_count:1 size:17918"} {"level":"info","ts":"2026-02-13T01:58:12.911405Z","caller":"traceutil/trace.go:171","msg":"trace[615074846] range","detail":"{range_begin:/registry/pods/kube-system/cilium-c8h9s; range_end:; response_count:1; response_revision:600; }","duration":"125.524415ms","start":"2026-02-13T01:58:12.785863Z","end":"2026-02-13T01:58:12.911387Z","steps":["trace[615074846] 'agreement among raft nodes before linearized reading' (duration: 125.398774ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T01:58:12.910815Z","caller":"traceutil/trace.go:171","msg":"trace[959828838] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"257.969541ms","start":"2026-02-13T01:58:12.652839Z","end":"2026-02-13T01:58:12.910809Z","steps":["trace[959828838] 'process raft request' (duration: 257.55146ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T01:58:12.917129Z","caller":"traceutil/trace.go:171","msg":"trace[239572800] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"128.134023ms","start":"2026-02-13T01:58:12.788987Z","end":"2026-02-13T01:58:12.917121Z","steps":["trace[239572800] 'process raft request' (duration: 128.026592ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T01:58:13.368357Z","caller":"traceutil/trace.go:171","msg":"trace[129178743] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"162.696837ms","start":"2026-02-13T01:58:13.205644Z","end":"2026-02-13T01:58:13.368341Z","steps":["trace[129178743] 'process raft request' (duration: 161.870764ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T01:58:13.373892Z","caller":"traceutil/trace.go:171","msg":"trace[356585934] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:623; }","duration":"151.631344ms","start":"2026-02-13T01:58:13.222254Z","end":"2026-02-13T01:58:13.373885Z","steps":["trace[356585934] 'read index received' (duration: 145.219795ms)","trace[356585934] 'applied index is now lower than readState.Index' (duration: 6.411119ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T01:58:13.376316Z","caller":"traceutil/trace.go:171","msg":"trace[1209524171] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"170.008248ms","start":"2026-02-13T01:58:13.20628Z","end":"2026-02-13T01:58:13.376289Z","steps":["trace[1209524171] 'process raft request' (duration: 167.557511ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:13.376784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.516983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-13T01:58:13.376895Z","caller":"traceutil/trace.go:171","msg":"trace[1219096814] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:606; }","duration":"154.628903ms","start":"2026-02-13T01:58:13.222234Z","end":"2026-02-13T01:58:13.376862Z","steps":["trace[1219096814] 'agreement among raft nodes before linearized reading' (duration: 154.417753ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:13.377186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.239678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:4333"} {"level":"info","ts":"2026-02-13T01:58:13.377304Z","caller":"traceutil/trace.go:171","msg":"trace[1457152712] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:606; }","duration":"153.366368ms","start":"2026-02-13T01:58:13.223929Z","end":"2026-02-13T01:58:13.377296Z","steps":["trace[1457152712] 'agreement among raft nodes before linearized reading' (duration: 153.216278ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T01:58:13.696605Z","caller":"traceutil/trace.go:171","msg":"trace[780036970] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"280.472458ms","start":"2026-02-13T01:58:13.416118Z","end":"2026-02-13T01:58:13.69659Z","steps":["trace[780036970] 'process raft request' (duration: 280.268617ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T01:58:13.696693Z","caller":"traceutil/trace.go:171","msg":"trace[1962846727] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:626; }","duration":"261.773873ms","start":"2026-02-13T01:58:13.43491Z","end":"2026-02-13T01:58:13.696684Z","steps":["trace[1962846727] 'read index received' (duration: 261.762193ms)","trace[1962846727] 'applied index is now lower than readState.Index' (duration: 11.12µs)"],"step_count":2} {"level":"warn","ts":"2026-02-13T01:58:13.69711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.184274ms","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-13T01:58:13.697246Z","caller":"traceutil/trace.go:171","msg":"trace[669775486] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:607; }","duration":"262.330064ms","start":"2026-02-13T01:58:13.434906Z","end":"2026-02-13T01:58:13.697236Z","steps":["trace[669775486] 'agreement among raft nodes before linearized reading' (duration: 261.841553ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T01:58:13.858348Z","caller":"traceutil/trace.go:171","msg":"trace[1319848381] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:626; }","duration":"161.619492ms","start":"2026-02-13T01:58:13.696713Z","end":"2026-02-13T01:58:13.858333Z","steps":["trace[1319848381] 'read index received' (duration: 161.241111ms)","trace[1319848381] 'applied index is now lower than readState.Index' (duration: 377.841µs)"],"step_count":2} {"level":"warn","ts":"2026-02-13T01:58:13.85859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.917068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T01:58:13.858633Z","caller":"traceutil/trace.go:171","msg":"trace[521073735] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:608; }","duration":"226.979468ms","start":"2026-02-13T01:58:13.631647Z","end":"2026-02-13T01:58:13.858626Z","steps":["trace[521073735] 'agreement among raft nodes before linearized reading' (duration: 226.890598ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:13.858916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.776512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188495"} {"level":"info","ts":"2026-02-13T01:58:13.859916Z","caller":"traceutil/trace.go:171","msg":"trace[2025047557] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:608; }","duration":"235.827744ms","start":"2026-02-13T01:58:13.624079Z","end":"2026-02-13T01:58:13.859907Z","steps":["trace[2025047557] 'agreement among raft nodes before linearized reading' (duration: 234.724272ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T01:58:13.858399Z","caller":"traceutil/trace.go:171","msg":"trace[1932091769] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"403.892177ms","start":"2026-02-13T01:58:13.454485Z","end":"2026-02-13T01:58:13.858377Z","steps":["trace[1932091769] 'process raft request' (duration: 403.635987ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:13.860318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:58:13.454469Z","time spent":"405.760803ms","remote":"127.0.0.1:58652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T01:58:14.03779Z","caller":"traceutil/trace.go:171","msg":"trace[724277485] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"164.755752ms","start":"2026-02-13T01:58:13.872985Z","end":"2026-02-13T01:58:14.037741Z","steps":["trace[724277485] 'process raft request' (duration: 85.910186ms)","trace[724277485] 'compare' (duration: 78.718625ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T01:58:14.43926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.269389ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-13T01:58:14.439399Z","caller":"traceutil/trace.go:171","msg":"trace[284643895] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:628; }","duration":"299.160024ms","start":"2026-02-13T01:58:14.140179Z","end":"2026-02-13T01:58:14.439339Z","steps":["trace[284643895] 'read index received' (duration: 4.701184ms)","trace[284643895] 'applied index is now lower than readState.Index' (duration: 294.45783ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T01:58:14.439464Z","caller":"traceutil/trace.go:171","msg":"trace[511700602] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"352.913024ms","start":"2026-02-13T01:58:14.086539Z","end":"2026-02-13T01:58:14.439452Z","steps":["trace[511700602] 'process raft request' (duration: 58.374754ms)","trace[511700602] 'compare' (duration: 294.143009ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T01:58:14.439513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:58:14.086531Z","time spent":"352.959074ms","remote":"127.0.0.1:58676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":780,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-13T01:58:14.439849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.661615ms","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-13T01:58:14.439881Z","caller":"traceutil/trace.go:171","msg":"trace[118751928] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:610; }","duration":"299.716415ms","start":"2026-02-13T01:58:14.140155Z","end":"2026-02-13T01:58:14.439871Z","steps":["trace[118751928] 'agreement among raft nodes before linearized reading' (duration: 299.558605ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:14.440455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.303976ms","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-13T01:58:14.440494Z","caller":"traceutil/trace.go:171","msg":"trace[651962114] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:611; }","duration":"293.354126ms","start":"2026-02-13T01:58:14.14713Z","end":"2026-02-13T01:58:14.440484Z","steps":["trace[651962114] 'agreement among raft nodes before linearized reading' (duration: 293.241196ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T01:58:14.440717Z","caller":"traceutil/trace.go:171","msg":"trace[368124603] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"275.583703ms","start":"2026-02-13T01:58:14.16512Z","end":"2026-02-13T01:58:14.440704Z","steps":["trace[368124603] 'process raft request' (duration: 275.184302ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:14.441002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.880452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-13T01:58:14.441045Z","caller":"traceutil/trace.go:171","msg":"trace[1882595543] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:611; }","duration":"165.087642ms","start":"2026-02-13T01:58:14.275946Z","end":"2026-02-13T01:58:14.441033Z","steps":["trace[1882595543] 'agreement among raft nodes before linearized reading' (duration: 164.875542ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:14.44119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.92597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T01:58:14.441222Z","caller":"traceutil/trace.go:171","msg":"trace[1614263762] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:611; }","duration":"213.96003ms","start":"2026-02-13T01:58:14.227253Z","end":"2026-02-13T01:58:14.441213Z","steps":["trace[1614263762] 'agreement among raft nodes before linearized reading' (duration: 213.90692ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:14.442951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.226802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T01:58:14.443059Z","caller":"traceutil/trace.go:171","msg":"trace[900483313] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:611; }","duration":"275.324782ms","start":"2026-02-13T01:58:14.167706Z","end":"2026-02-13T01:58:14.443031Z","steps":["trace[900483313] 'agreement among raft nodes before linearized reading' (duration: 275.215592ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:14.443315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.071565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T01:58:14.443385Z","caller":"traceutil/trace.go:171","msg":"trace[1145317280] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:611; }","duration":"216.141725ms","start":"2026-02-13T01:58:14.227234Z","end":"2026-02-13T01:58:14.443376Z","steps":["trace[1145317280] 'agreement among raft nodes before linearized reading' (duration: 216.058785ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:14.443506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.340336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T01:58:14.443553Z","caller":"traceutil/trace.go:171","msg":"trace[1470774184] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:611; }","duration":"216.419196ms","start":"2026-02-13T01:58:14.227128Z","end":"2026-02-13T01:58:14.443547Z","steps":["trace[1470774184] 'agreement among raft nodes before linearized reading' (duration: 216.360716ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:14.44367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.982675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T01:58:14.443717Z","caller":"traceutil/trace.go:171","msg":"trace[1595203215] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:611; }","duration":"243.029635ms","start":"2026-02-13T01:58:14.200681Z","end":"2026-02-13T01:58:14.44371Z","steps":["trace[1595203215] 'agreement among raft nodes before linearized reading' (duration: 242.954645ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:14.44398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.306907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T01:58:14.444029Z","caller":"traceutil/trace.go:171","msg":"trace[209146542] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:611; }","duration":"243.365357ms","start":"2026-02-13T01:58:14.200656Z","end":"2026-02-13T01:58:14.444022Z","steps":["trace[209146542] 'agreement among raft nodes before linearized reading' (duration: 243.299237ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:14.444258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.605658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T01:58:14.444328Z","caller":"traceutil/trace.go:171","msg":"trace[537744176] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:611; }","duration":"243.697588ms","start":"2026-02-13T01:58:14.200624Z","end":"2026-02-13T01:58:14.444321Z","steps":["trace[537744176] 'agreement among raft nodes before linearized reading' (duration: 243.611868ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:14.444537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.802967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T01:58:14.444612Z","caller":"traceutil/trace.go:171","msg":"trace[1177786066] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:611; }","duration":"276.879798ms","start":"2026-02-13T01:58:14.167725Z","end":"2026-02-13T01:58:14.444605Z","steps":["trace[1177786066] 'agreement among raft nodes before linearized reading' (duration: 276.789227ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:14.447023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.321505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T01:58:14.447501Z","caller":"traceutil/trace.go:171","msg":"trace[677285580] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:611; }","duration":"279.829946ms","start":"2026-02-13T01:58:14.167662Z","end":"2026-02-13T01:58:14.447492Z","steps":["trace[677285580] 'agreement among raft nodes before linearized reading' (duration: 279.336635ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:14.447963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.184727ms","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-13T01:58:14.448278Z","caller":"traceutil/trace.go:171","msg":"trace[1873307613] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:611; }","duration":"300.507867ms","start":"2026-02-13T01:58:14.147761Z","end":"2026-02-13T01:58:14.448269Z","steps":["trace[1873307613] 'agreement among raft nodes before linearized reading' (duration: 300.153846ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:58:14.448385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:58:14.147757Z","time spent":"300.618528ms","remote":"127.0.0.1:58866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-13T01:58:14.622413Z","caller":"traceutil/trace.go:171","msg":"trace[167211470] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"162.618756ms","start":"2026-02-13T01:58:14.45978Z","end":"2026-02-13T01:58:14.622399Z","steps":["trace[167211470] 'process raft request' (duration: 162.592526ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T01:58:14.62259Z","caller":"traceutil/trace.go:171","msg":"trace[839450832] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"164.068309ms","start":"2026-02-13T01:58:14.4585Z","end":"2026-02-13T01:58:14.622568Z","steps":["trace[839450832] 'process raft request' (duration: 146.206456ms)","trace[839450832] 'compare' (duration: 17.597753ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T01:58:14.839931Z","caller":"traceutil/trace.go:171","msg":"trace[653942108] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"130.25387ms","start":"2026-02-13T01:58:14.709657Z","end":"2026-02-13T01:58:14.83991Z","steps":["trace[653942108] 'process raft request' (duration: 85.380286ms)","trace[653942108] 'compare' (duration: 44.747564ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T01:58:14.880312Z","caller":"traceutil/trace.go:171","msg":"trace[18850164] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"168.945394ms","start":"2026-02-13T01:58:14.711351Z","end":"2026-02-13T01:58:14.880296Z","steps":["trace[18850164] 'process raft request' (duration: 168.864434ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T01:59:25.042725Z","caller":"traceutil/trace.go:171","msg":"trace[1324989646] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"197.096118ms","start":"2026-02-13T01:59:24.845607Z","end":"2026-02-13T01:59:25.042703Z","steps":["trace[1324989646] 'process raft request' (duration: 196.932168ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:59:34.136649Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15490021331035196291,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-13T01:59:34.525961Z","caller":"traceutil/trace.go:171","msg":"trace[2103812861] linearizableReadLoop","detail":"{readStateIndex:995; appliedIndex:994; }","duration":"890.226624ms","start":"2026-02-13T01:59:33.635719Z","end":"2026-02-13T01:59:34.525946Z","steps":["trace[2103812861] 'read index received' (duration: 890.079204ms)","trace[2103812861] 'applied index is now lower than readState.Index' (duration: 146.98µs)"],"step_count":2} {"level":"info","ts":"2026-02-13T01:59:34.526237Z","caller":"traceutil/trace.go:171","msg":"trace[1102252539] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"981.71214ms","start":"2026-02-13T01:59:33.544518Z","end":"2026-02-13T01:59:34.52623Z","steps":["trace[1102252539] 'process raft request' (duration: 981.329172ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:59:34.526314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:59:33.544501Z","time spent":"981.756483ms","remote":"127.0.0.1:58866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T01:59:34.526345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.897102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-13T01:59:34.526399Z","caller":"traceutil/trace.go:171","msg":"trace[1842192891] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:958; }","duration":"384.991729ms","start":"2026-02-13T01:59:34.141393Z","end":"2026-02-13T01:59:34.526385Z","steps":["trace[1842192891] 'agreement among raft nodes before linearized reading' (duration: 384.793785ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:59:34.526428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:59:34.141378Z","time spent":"385.044733ms","remote":"127.0.0.1:58866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-13T01:59:34.526497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.791125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T01:59:34.52653Z","caller":"traceutil/trace.go:171","msg":"trace[136492113] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:958; }","duration":"890.85881ms","start":"2026-02-13T01:59:33.635664Z","end":"2026-02-13T01:59:34.526523Z","steps":["trace[136492113] 'agreement among raft nodes before linearized reading' (duration: 890.816117ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T01:59:34.526544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T01:59:33.635644Z","time spent":"890.896733ms","remote":"127.0.0.1:58608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}