{"level":"warn","ts":"2026-02-10T21:25:28.867426Z","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-10T21:25:28.867545Z","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-10T21:25:28.867634Z","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-10T21:25:28.867647Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.217:2380"]} {"level":"info","ts":"2026-02-10T21:25:28.867666Z","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-10T21:25:28.868375Z","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-10T21:25:28.868481Z","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-10T21:25:28.875473Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.750969ms"} {"level":"info","ts":"2026-02-10T21:25:28.89601Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f1e368e6818bd6f7","cluster-id":"289e52865b7eaeb1"} {"level":"info","ts":"2026-02-10T21:25:28.896095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 switched to configuration voters=()"} {"level":"info","ts":"2026-02-10T21:25:28.896121Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became follower at term 0"} {"level":"info","ts":"2026-02-10T21:25:28.896131Z","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-10T21:25:28.896144Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became follower at term 1"} {"level":"info","ts":"2026-02-10T21:25:28.896175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 switched to configuration voters=(17429890322079143671)"} {"level":"warn","ts":"2026-02-10T21:25:28.917896Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-10T21:25:28.92514Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-10T21:25:28.93636Z","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-10T21:25:28.946784Z","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-10T21:25:28.947732Z","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-10T21:25:28.962187Z","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-10T21:25:28.96246Z","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-10T21:25:28.962483Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-10T21:25:28.962545Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.217:2380"} {"level":"info","ts":"2026-02-10T21:25:28.962564Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.217:2380"} {"level":"info","ts":"2026-02-10T21:25:28.962738Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 switched to configuration voters=(17429890322079143671)"} {"level":"info","ts":"2026-02-10T21:25:28.96291Z","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-10T21:25:28.963031Z","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-10T21:25:28.963105Z","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-10T21:25:28.963161Z","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-10T21:25:29.097841Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 is starting a new election at term 1"} {"level":"info","ts":"2026-02-10T21:25:29.097889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-10T21:25:29.097908Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 received MsgPreVoteResp from f1e368e6818bd6f7 at term 1"} {"level":"info","ts":"2026-02-10T21:25:29.09792Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became candidate at term 2"} {"level":"info","ts":"2026-02-10T21:25:29.097926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 received MsgVoteResp from f1e368e6818bd6f7 at term 2"} {"level":"info","ts":"2026-02-10T21:25:29.097935Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became leader at term 2"} {"level":"info","ts":"2026-02-10T21:25:29.097945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f1e368e6818bd6f7 elected leader f1e368e6818bd6f7 at term 2"} {"level":"info","ts":"2026-02-10T21:25:29.100737Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T21:25:29.106279Z","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-10T21:25:29.106468Z","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-10T21:25:29.106552Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T21:25:29.106582Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T21:25:29.10659Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-10T21:25:29.106618Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-10T21:25:29.107113Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-10T21:25:29.113759Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-10T21:25:29.110779Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-10T21:25:29.136553Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.217:2379"} {"level":"warn","ts":"2026-02-10T21:25:39.990943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.745527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5270"} {"level":"info","ts":"2026-02-10T21:25:39.991084Z","caller":"traceutil/trace.go:171","msg":"trace[686086542] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:314; }","duration":"466.933261ms","start":"2026-02-10T21:25:39.524133Z","end":"2026-02-10T21:25:39.991067Z","steps":["trace[686086542] 'range keys from in-memory index tree' (duration: 466.673856ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:25:39.991126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:25:39.524111Z","time spent":"467.006882ms","remote":"127.0.0.1:43966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":5293,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"warn","ts":"2026-02-10T21:25:39.991294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.349998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-02-10T21:25:39.991314Z","caller":"traceutil/trace.go:171","msg":"trace[1278613763] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:314; }","duration":"451.408579ms","start":"2026-02-10T21:25:39.539898Z","end":"2026-02-10T21:25:39.991307Z","steps":["trace[1278613763] 'range keys from in-memory index tree' (duration: 451.270516ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:25:39.991335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:25:39.539874Z","time spent":"451.45259ms","remote":"127.0.0.1:43972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":257,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"warn","ts":"2026-02-10T21:25:39.991419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.843771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-10T21:25:39.991438Z","caller":"traceutil/trace.go:171","msg":"trace[1003766812] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:314; }","duration":"401.863711ms","start":"2026-02-10T21:25:39.58957Z","end":"2026-02-10T21:25:39.991433Z","steps":["trace[1003766812] 'range keys from in-memory index tree' (duration: 401.771178ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:25:39.991456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:25:39.589504Z","time spent":"401.946932ms","remote":"127.0.0.1:43972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "} {"level":"warn","ts":"2026-02-10T21:25:39.991599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.087254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-10T21:25:39.991616Z","caller":"traceutil/trace.go:171","msg":"trace[1810334159] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:314; }","duration":"351.172636ms","start":"2026-02-10T21:25:39.640438Z","end":"2026-02-10T21:25:39.991611Z","steps":["trace[1810334159] 'range keys from in-memory index tree' (duration: 350.987752ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:25:39.991637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:25:39.640413Z","time spent":"351.219457ms","remote":"127.0.0.1:43972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"warn","ts":"2026-02-10T21:25:39.991771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.806886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-10T21:25:39.991792Z","caller":"traceutil/trace.go:171","msg":"trace[97617299] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:314; }","duration":"298.900809ms","start":"2026-02-10T21:25:39.692883Z","end":"2026-02-10T21:25:39.991783Z","steps":["trace[97617299] 'range keys from in-memory index tree' (duration: 298.679653ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:25:39.991943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.785513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-02-10T21:25:39.991962Z","caller":"traceutil/trace.go:171","msg":"trace[401999712] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:314; }","duration":"251.863774ms","start":"2026-02-10T21:25:39.740092Z","end":"2026-02-10T21:25:39.991956Z","steps":["trace[401999712] 'range keys from in-memory index tree' (duration: 251.659ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:25:39.992055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.00781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-02-10T21:25:39.992074Z","caller":"traceutil/trace.go:171","msg":"trace[596490823] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:314; }","duration":"203.075462ms","start":"2026-02-10T21:25:39.788992Z","end":"2026-02-10T21:25:39.992068Z","steps":["trace[596490823] 'range keys from in-memory index tree' (duration: 202.947709ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:25:39.992159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.379906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T21:25:39.992177Z","caller":"traceutil/trace.go:171","msg":"trace[891042618] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:314; }","duration":"161.460468ms","start":"2026-02-10T21:25:39.830709Z","end":"2026-02-10T21:25:39.99217Z","steps":["trace[891042618] 'range keys from in-memory index tree' (duration: 161.311205ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:25:39.992294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.098794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-02-10T21:25:39.992315Z","caller":"traceutil/trace.go:171","msg":"trace[125295456] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:314; }","duration":"153.119245ms","start":"2026-02-10T21:25:39.839189Z","end":"2026-02-10T21:25:39.992308Z","steps":["trace[125295456] 'range keys from in-memory index tree' (duration: 153.029953ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:25:39.992409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.525052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-02-10T21:25:39.992426Z","caller":"traceutil/trace.go:171","msg":"trace[380855290] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:314; }","duration":"102.631144ms","start":"2026-02-10T21:25:39.889789Z","end":"2026-02-10T21:25:39.99242Z","steps":["trace[380855290] 'range keys from in-memory index tree' (duration: 102.401779ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:25:45.588135Z","caller":"traceutil/trace.go:171","msg":"trace[1399084495] linearizableReadLoop","detail":"{readStateIndex:388; appliedIndex:387; }","duration":"258.91745ms","start":"2026-02-10T21:25:45.329195Z","end":"2026-02-10T21:25:45.588113Z","steps":["trace[1399084495] 'read index received' (duration: 257.678412ms)","trace[1399084495] 'applied index is now lower than readState.Index' (duration: 1.238368ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:25:45.588244Z","caller":"traceutil/trace.go:171","msg":"trace[842429043] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"309.089533ms","start":"2026-02-10T21:25:45.279147Z","end":"2026-02-10T21:25:45.588236Z","steps":["trace[842429043] 'process raft request' (duration: 307.806854ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:25:45.588753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:25:45.279126Z","time spent":"309.142624ms","remote":"127.0.0.1:44034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T21:25:45.5891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.900661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-02-10T21:25:45.589072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.119654ms","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-10T21:25:45.589176Z","caller":"traceutil/trace.go:171","msg":"trace[1240955489] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:377; }","duration":"259.84068ms","start":"2026-02-10T21:25:45.329314Z","end":"2026-02-10T21:25:45.589155Z","steps":["trace[1240955489] 'agreement among raft nodes before linearized reading' (duration: 259.137965ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:25:45.589131Z","caller":"traceutil/trace.go:171","msg":"trace[358298512] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:377; }","duration":"259.951183ms","start":"2026-02-10T21:25:45.329172Z","end":"2026-02-10T21:25:45.589123Z","steps":["trace[358298512] 'agreement among raft nodes before linearized reading' (duration: 259.892012ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:26:01.70705Z","caller":"traceutil/trace.go:171","msg":"trace[1098987302] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"100.910577ms","start":"2026-02-10T21:26:01.606119Z","end":"2026-02-10T21:26:01.70703Z","steps":["trace[1098987302] 'process raft request' (duration: 100.251432ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:26:03.515379Z","caller":"traceutil/trace.go:171","msg":"trace[287415335] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"234.418132ms","start":"2026-02-10T21:26:03.280935Z","end":"2026-02-10T21:26:03.515353Z","steps":["trace[287415335] 'process raft request' (duration: 206.288154ms)","trace[287415335] 'compare' (duration: 27.928493ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:26:03.893832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.07655ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-10T21:26:03.894099Z","caller":"traceutil/trace.go:171","msg":"trace[1903852501] linearizableReadLoop","detail":"{readStateIndex:532; appliedIndex:530; }","duration":"259.817359ms","start":"2026-02-10T21:26:03.634261Z","end":"2026-02-10T21:26:03.894078Z","steps":["trace[1903852501] 'read index received' (duration: 2.177607ms)","trace[1903852501] 'applied index is now lower than readState.Index' (duration: 257.638702ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:26:03.894869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.574306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T21:26:03.89496Z","caller":"traceutil/trace.go:171","msg":"trace[982533569] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:515; }","duration":"260.74508ms","start":"2026-02-10T21:26:03.634192Z","end":"2026-02-10T21:26:03.894937Z","steps":["trace[982533569] 'agreement among raft nodes before linearized reading' (duration: 260.569726ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:26:03.895154Z","caller":"traceutil/trace.go:171","msg":"trace[1058962021] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"457.155727ms","start":"2026-02-10T21:26:03.437984Z","end":"2026-02-10T21:26:03.895139Z","steps":["trace[1058962021] 'process raft request' (duration: 198.444981ms)","trace[1058962021] 'compare' (duration: 256.842475ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:26:03.895236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:26:03.437955Z","time spent":"457.224228ms","remote":"127.0.0.1:43832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T21:26:03.895442Z","caller":"traceutil/trace.go:171","msg":"trace[1695864515] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"374.156302ms","start":"2026-02-10T21:26:03.521275Z","end":"2026-02-10T21:26:03.895431Z","steps":["trace[1695864515] 'process raft request' (duration: 372.69308ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:26:03.895508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:26:03.521255Z","time spent":"374.209964ms","remote":"127.0.0.1:43832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4318,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T21:26:03.894978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.371146ms","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-10T21:26:03.895679Z","caller":"traceutil/trace.go:171","msg":"trace[168445853] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:515; }","duration":"177.120763ms","start":"2026-02-10T21:26:03.718547Z","end":"2026-02-10T21:26:03.895668Z","steps":["trace[168445853] 'agreement among raft nodes before linearized reading' (duration: 176.347606ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:26:03.896132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.844379ms","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-10T21:26:03.896165Z","caller":"traceutil/trace.go:171","msg":"trace[1258632216] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:515; }","duration":"142.925531ms","start":"2026-02-10T21:26:03.75323Z","end":"2026-02-10T21:26:03.896155Z","steps":["trace[1258632216] 'agreement among raft nodes before linearized reading' (duration: 142.846419ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:26:05.57364Z","caller":"traceutil/trace.go:171","msg":"trace[539740483] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"109.704831ms","start":"2026-02-10T21:26:05.463909Z","end":"2026-02-10T21:26:05.573614Z","steps":["trace[539740483] 'process raft request' (duration: 109.548778ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:26:07.299939Z","caller":"traceutil/trace.go:171","msg":"trace[1570116956] linearizableReadLoop","detail":"{readStateIndex:556; appliedIndex:555; }","duration":"141.723035ms","start":"2026-02-10T21:26:07.15806Z","end":"2026-02-10T21:26:07.299783Z","steps":["trace[1570116956] 'read index received' (duration: 141.365407ms)","trace[1570116956] 'applied index is now lower than readState.Index' (duration: 356.598µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:26:07.300215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.320947ms","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-10T21:26:07.305839Z","caller":"traceutil/trace.go:171","msg":"trace[419834936] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:539; }","duration":"148.061883ms","start":"2026-02-10T21:26:07.157758Z","end":"2026-02-10T21:26:07.30582Z","steps":["trace[419834936] 'agreement among raft nodes before linearized reading' (duration: 142.347448ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:26:07.300294Z","caller":"traceutil/trace.go:171","msg":"trace[469335211] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"164.641847ms","start":"2026-02-10T21:26:07.135642Z","end":"2026-02-10T21:26:07.300284Z","steps":["trace[469335211] 'process raft request' (duration: 163.85834ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:26:07.306248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.307397ms","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-10T21:26:07.306346Z","caller":"traceutil/trace.go:171","msg":"trace[1627275023] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:539; }","duration":"112.41988ms","start":"2026-02-10T21:26:07.193894Z","end":"2026-02-10T21:26:07.306314Z","steps":["trace[1627275023] 'agreement among raft nodes before linearized reading' (duration: 112.336608ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:26:07.300354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.630708ms","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-10T21:26:07.30679Z","caller":"traceutil/trace.go:171","msg":"trace[653120644] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:539; }","duration":"156.07494ms","start":"2026-02-10T21:26:07.150699Z","end":"2026-02-10T21:26:07.306774Z","steps":["trace[653120644] 'agreement among raft nodes before linearized reading' (duration: 149.615267ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:26:07.300418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.711839ms","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-10T21:26:07.307211Z","caller":"traceutil/trace.go:171","msg":"trace[135949278] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:539; }","duration":"156.55775ms","start":"2026-02-10T21:26:07.150639Z","end":"2026-02-10T21:26:07.307197Z","steps":["trace[135949278] 'agreement among raft nodes before linearized reading' (duration: 149.733319ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:26:07.305741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.129704ms","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-10T21:26:07.307532Z","caller":"traceutil/trace.go:171","msg":"trace[304886946] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:539; }","duration":"114.022216ms","start":"2026-02-10T21:26:07.1935Z","end":"2026-02-10T21:26:07.307523Z","steps":["trace[304886946] 'agreement among raft nodes before linearized reading' (duration: 112.160435ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:26:07.306214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.213515ms","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-10T21:26:07.30958Z","caller":"traceutil/trace.go:171","msg":"trace[1907692989] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:539; }","duration":"115.605981ms","start":"2026-02-10T21:26:07.193964Z","end":"2026-02-10T21:26:07.30957Z","steps":["trace[1907692989] 'agreement among raft nodes before linearized reading' (duration: 112.196316ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:26:11.592345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.038451ms","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-10T21:26:11.592443Z","caller":"traceutil/trace.go:171","msg":"trace[1044350094] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:551; }","duration":"420.212335ms","start":"2026-02-10T21:26:11.172209Z","end":"2026-02-10T21:26:11.592421Z","steps":["trace[1044350094] 'range keys from in-memory index tree' (duration: 419.832206ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:26:11.592502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:26:11.172186Z","time spent":"420.308938ms","remote":"127.0.0.1:44034","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-10T21:26:11.592818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.183886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/kube-system/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T21:26:11.592843Z","caller":"traceutil/trace.go:171","msg":"trace[612777391] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/kube-system/; range_end:/registry/cilium.io/ciliumnodeconfigs/kube-system0; response_count:0; response_revision:551; }","duration":"553.225839ms","start":"2026-02-10T21:26:11.039611Z","end":"2026-02-10T21:26:11.592837Z","steps":["trace[612777391] 'range keys from in-memory index tree' (duration: 553.156066ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:26:11.592866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:26:11.039605Z","time spent":"553.255079ms","remote":"127.0.0.1:59640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/kube-system/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs/kube-system0\" "} {"level":"info","ts":"2026-02-10T21:26:11.857036Z","caller":"traceutil/trace.go:171","msg":"trace[43804647] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"259.750948ms","start":"2026-02-10T21:26:11.597257Z","end":"2026-02-10T21:26:11.857007Z","steps":["trace[43804647] 'process raft request' (duration: 259.508883ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:26:11.857829Z","caller":"traceutil/trace.go:171","msg":"trace[343633513] linearizableReadLoop","detail":"{readStateIndex:570; appliedIndex:570; }","duration":"234.940842ms","start":"2026-02-10T21:26:11.622845Z","end":"2026-02-10T21:26:11.857786Z","steps":["trace[343633513] 'read index received' (duration: 234.935182ms)","trace[343633513] 'applied index is now lower than readState.Index' (duration: 4.69µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:26:11.858141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.114326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-cwsnq\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-10T21:26:11.858303Z","caller":"traceutil/trace.go:171","msg":"trace[1864049372] range","detail":"{range_begin:/registry/pods/kube-system/cilium-cwsnq; range_end:; response_count:1; response_revision:552; }","duration":"235.381592ms","start":"2026-02-10T21:26:11.622795Z","end":"2026-02-10T21:26:11.858176Z","steps":["trace[1864049372] 'agreement among raft nodes before linearized reading' (duration: 235.112577ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:26:12.182214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.778231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-10T21:26:12.182272Z","caller":"traceutil/trace.go:171","msg":"trace[1914123164] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:553; }","duration":"113.914853ms","start":"2026-02-10T21:26:12.068345Z","end":"2026-02-10T21:26:12.18226Z","steps":["trace[1914123164] 'range keys from in-memory index tree' (duration: 113.601727ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:26:12.295292Z","caller":"traceutil/trace.go:171","msg":"trace[2030996559] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"108.933504ms","start":"2026-02-10T21:26:12.186316Z","end":"2026-02-10T21:26:12.295249Z","steps":["trace[2030996559] 'process raft request' (duration: 108.77017ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:26:12.299949Z","caller":"traceutil/trace.go:171","msg":"trace[890892577] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"112.669576ms","start":"2026-02-10T21:26:12.187266Z","end":"2026-02-10T21:26:12.299936Z","steps":["trace[890892577] 'process raft request' (duration: 112.256927ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:26:12.300307Z","caller":"traceutil/trace.go:171","msg":"trace[18098167] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:571; }","duration":"101.883849ms","start":"2026-02-10T21:26:12.198414Z","end":"2026-02-10T21:26:12.300298Z","steps":["trace[18098167] 'read index received' (duration: 96.629443ms)","trace[18098167] 'applied index is now lower than readState.Index' (duration: 5.253816ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:26:12.305294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.861058ms","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-10T21:26:12.30593Z","caller":"traceutil/trace.go:171","msg":"trace[1607529653] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:556; }","duration":"107.534762ms","start":"2026-02-10T21:26:12.19838Z","end":"2026-02-10T21:26:12.305915Z","steps":["trace[1607529653] 'agreement among raft nodes before linearized reading' (duration: 101.95544ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:26:23.432153Z","caller":"traceutil/trace.go:171","msg":"trace[1327998251] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"309.608254ms","start":"2026-02-10T21:26:23.122528Z","end":"2026-02-10T21:26:23.432136Z","steps":["trace[1327998251] 'process raft request' (duration: 309.494882ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:26:23.432292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:26:23.1225Z","time spent":"309.753047ms","remote":"127.0.0.1:38366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1234,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T21:26:24.10624Z","caller":"traceutil/trace.go:171","msg":"trace[969057164] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"659.654754ms","start":"2026-02-10T21:26:23.446401Z","end":"2026-02-10T21:26:24.106055Z","steps":["trace[969057164] 'process raft request' (duration: 634.662835ms)","trace[969057164] 'compare' (duration: 24.825506ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:26:24.106887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:26:23.446386Z","time spent":"660.412102ms","remote":"127.0.0.1:38326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2261,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T21:26:24.158037Z","caller":"traceutil/trace.go:171","msg":"trace[1348889591] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"711.063205ms","start":"2026-02-10T21:26:23.446486Z","end":"2026-02-10T21:26:24.157549Z","steps":["trace[1348889591] 'process raft request' (duration: 710.902761ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:26:24.158143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:26:23.446468Z","time spent":"711.617107ms","remote":"127.0.0.1:38326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2260,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T21:26:24.158263Z","caller":"traceutil/trace.go:171","msg":"trace[298957367] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:657; }","duration":"341.191428ms","start":"2026-02-10T21:26:23.816328Z","end":"2026-02-10T21:26:24.15752Z","steps":["trace[298957367] 'read index received' (duration: 264.740827ms)","trace[298957367] 'applied index is now lower than readState.Index' (duration: 76.450021ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:26:24.1583Z","caller":"traceutil/trace.go:171","msg":"trace[897812485] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"711.75932ms","start":"2026-02-10T21:26:23.446536Z","end":"2026-02-10T21:26:24.158295Z","steps":["trace[897812485] 'process raft request' (duration: 710.951242ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:26:24.15848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:26:23.446533Z","time spent":"711.78096ms","remote":"127.0.0.1:38326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2260,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-10T21:26:24.159249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.917245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T21:26:24.159285Z","caller":"traceutil/trace.go:171","msg":"trace[785364968] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:638; }","duration":"343.010087ms","start":"2026-02-10T21:26:23.816269Z","end":"2026-02-10T21:26:24.159279Z","steps":["trace[785364968] 'agreement among raft nodes before linearized reading' (duration: 342.962966ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:26:24.1593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:26:23.81625Z","time spent":"343.046807ms","remote":"127.0.0.1:43786","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-10T21:26:24.159589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.5786ms","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-10T21:26:24.159623Z","caller":"traceutil/trace.go:171","msg":"trace[517152458] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:638; }","duration":"242.637891ms","start":"2026-02-10T21:26:23.916978Z","end":"2026-02-10T21:26:24.159616Z","steps":["trace[517152458] 'agreement among raft nodes before linearized reading' (duration: 241.598029ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:26:24.458925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.964029ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T21:26:24.459616Z","caller":"traceutil/trace.go:171","msg":"trace[1653122643] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"290.240308ms","start":"2026-02-10T21:26:24.169365Z","end":"2026-02-10T21:26:24.459605Z","steps":["trace[1653122643] 'process raft request' (duration: 41.199606ms)","trace[1653122643] 'compare' (duration: 247.715532ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:26:24.624264Z","caller":"traceutil/trace.go:171","msg":"trace[1464809029] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"160.361324ms","start":"2026-02-10T21:26:24.463867Z","end":"2026-02-10T21:26:24.624229Z","steps":["trace[1464809029] 'process raft request' (duration: 157.735936ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:26:24.624528Z","caller":"traceutil/trace.go:171","msg":"trace[493817145] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"153.695446ms","start":"2026-02-10T21:26:24.47082Z","end":"2026-02-10T21:26:24.624515Z","steps":["trace[493817145] 'process raft request' (duration: 153.671156ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:26:24.624663Z","caller":"traceutil/trace.go:171","msg":"trace[1637948424] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"153.993094ms","start":"2026-02-10T21:26:24.470665Z","end":"2026-02-10T21:26:24.624659Z","steps":["trace[1637948424] 'process raft request' (duration: 153.280139ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:26:24.62565Z","caller":"traceutil/trace.go:171","msg":"trace[1968243614] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"154.912924ms","start":"2026-02-10T21:26:24.470731Z","end":"2026-02-10T21:26:24.625644Z","steps":["trace[1968243614] 'process raft request' (duration: 153.233316ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:26:33.474654Z","caller":"traceutil/trace.go:171","msg":"trace[1554085833] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"624.251811ms","start":"2026-02-10T21:26:32.850384Z","end":"2026-02-10T21:26:33.474636Z","steps":["trace[1554085833] 'process raft request' (duration: 624.175399ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:26:33.474758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:26:32.850374Z","time spent":"624.336932ms","remote":"127.0.0.1:43858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":817,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T21:26:33.480979Z","caller":"traceutil/trace.go:171","msg":"trace[1430095414] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"429.769314ms","start":"2026-02-10T21:26:33.051195Z","end":"2026-02-10T21:26:33.480964Z","steps":["trace[1430095414] 'process raft request' (duration: 429.698313ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:26:33.481062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:26:33.051177Z","time spent":"429.840776ms","remote":"127.0.0.1:44034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T21:26:34.998224Z","caller":"traceutil/trace.go:171","msg":"trace[643947790] linearizableReadLoop","detail":"{readStateIndex:734; appliedIndex:731; }","duration":"178.61058ms","start":"2026-02-10T21:26:34.819598Z","end":"2026-02-10T21:26:34.998208Z","steps":["trace[643947790] 'read index received' (duration: 175.963235ms)","trace[643947790] 'applied index is now lower than readState.Index' (duration: 2.646715ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:26:34.9984Z","caller":"traceutil/trace.go:171","msg":"trace[13759004] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"261.055471ms","start":"2026-02-10T21:26:34.737337Z","end":"2026-02-10T21:26:34.998392Z","steps":["trace[13759004] 'process raft request' (duration: 258.276501ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:26:34.998517Z","caller":"traceutil/trace.go:171","msg":"trace[1335687731] transaction","detail":"{read_only:false; response_revision:709; number_of_response:1; }","duration":"259.201355ms","start":"2026-02-10T21:26:34.73931Z","end":"2026-02-10T21:26:34.998511Z","steps":["trace[1335687731] 'process raft request' (duration: 258.848975ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:26:34.998595Z","caller":"traceutil/trace.go:171","msg":"trace[1528292853] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"259.098532ms","start":"2026-02-10T21:26:34.739491Z","end":"2026-02-10T21:26:34.99859Z","steps":["trace[1528292853] 'process raft request' (duration: 258.694381ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:26:34.998696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.085933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T21:26:34.998736Z","caller":"traceutil/trace.go:171","msg":"trace[194167241] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:710; }","duration":"179.165915ms","start":"2026-02-10T21:26:34.819563Z","end":"2026-02-10T21:26:34.998729Z","steps":["trace[194167241] 'agreement among raft nodes before linearized reading' (duration: 179.103553ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:26:34.998881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.189782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-10T21:26:34.9989Z","caller":"traceutil/trace.go:171","msg":"trace[1636793334] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:710; }","duration":"122.246274ms","start":"2026-02-10T21:26:34.876648Z","end":"2026-02-10T21:26:34.998895Z","steps":["trace[1636793334] 'agreement among raft nodes before linearized reading' (duration: 122.208513ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:26:48.980962Z","caller":"traceutil/trace.go:171","msg":"trace[1292077331] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"161.251857ms","start":"2026-02-10T21:26:48.819693Z","end":"2026-02-10T21:26:48.980945Z","steps":["trace[1292077331] 'process raft request' (duration: 161.139965ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:26:50.791724Z","caller":"traceutil/trace.go:171","msg":"trace[1545020097] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"205.550613ms","start":"2026-02-10T21:26:50.586148Z","end":"2026-02-10T21:26:50.791699Z","steps":["trace[1545020097] 'process raft request' (duration: 205.42383ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:27:04.727887Z","caller":"traceutil/trace.go:171","msg":"trace[42266962] transaction","detail":"{read_only:false; response_revision:846; number_of_response:1; }","duration":"324.524265ms","start":"2026-02-10T21:27:04.403341Z","end":"2026-02-10T21:27:04.727865Z","steps":["trace[42266962] 'process raft request' (duration: 324.386022ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:27:04.728031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:27:04.403326Z","time spent":"324.629857ms","remote":"127.0.0.1:44034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T21:27:05.383354Z","caller":"traceutil/trace.go:171","msg":"trace[48063392] linearizableReadLoop","detail":"{readStateIndex:880; appliedIndex:879; }","duration":"120.142081ms","start":"2026-02-10T21:27:05.263178Z","end":"2026-02-10T21:27:05.38332Z","steps":["trace[48063392] 'read index received' (duration: 119.858154ms)","trace[48063392] 'applied index is now lower than readState.Index' (duration: 278.167µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:27:05.384497Z","caller":"traceutil/trace.go:171","msg":"trace[1560221935] transaction","detail":"{read_only:false; response_revision:848; number_of_response:1; }","duration":"263.90802ms","start":"2026-02-10T21:27:05.119877Z","end":"2026-02-10T21:27:05.383785Z","steps":["trace[1560221935] 'process raft request' (duration: 263.242854ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:27:05.384992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.788912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-02-10T21:27:05.385032Z","caller":"traceutil/trace.go:171","msg":"trace[200548140] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:848; }","duration":"121.886495ms","start":"2026-02-10T21:27:05.263134Z","end":"2026-02-10T21:27:05.385021Z","steps":["trace[200548140] 'agreement among raft nodes before linearized reading' (duration: 121.655388ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:27:05.871907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.870176ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T21:27:05.872367Z","caller":"traceutil/trace.go:171","msg":"trace[239550711] transaction","detail":"{read_only:false; response_revision:849; number_of_response:1; }","duration":"480.141282ms","start":"2026-02-10T21:27:05.39221Z","end":"2026-02-10T21:27:05.872352Z","steps":["trace[239550711] 'process raft request' (duration: 254.756132ms)","trace[239550711] 'compare' (duration: 224.744923ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:27:05.872422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:27:05.392186Z","time spent":"480.211984ms","remote":"127.0.0.1:44034","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-10T21:27:05.87251Z","caller":"traceutil/trace.go:171","msg":"trace[390938125] transaction","detail":"{read_only:false; response_revision:850; number_of_response:1; }","duration":"477.551688ms","start":"2026-02-10T21:27:05.394953Z","end":"2026-02-10T21:27:05.872504Z","steps":["trace[390938125] 'process raft request' (duration: 477.048164ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:27:05.872546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:27:05.394941Z","time spent":"477.587738ms","remote":"127.0.0.1:44034","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-10T21:27:05.87262Z","caller":"traceutil/trace.go:171","msg":"trace[1794017829] transaction","detail":"{read_only:false; response_revision:851; number_of_response:1; }","duration":"476.519231ms","start":"2026-02-10T21:27:05.396095Z","end":"2026-02-10T21:27:05.872614Z","steps":["trace[1794017829] 'process raft request' (duration: 475.970707ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:27:05.872653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:27:05.396087Z","time spent":"476.550002ms","remote":"127.0.0.1:44034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T21:27:06.855988Z","caller":"traceutil/trace.go:171","msg":"trace[1263520090] transaction","detail":"{read_only:false; response_revision:852; number_of_response:1; }","duration":"397.067597ms","start":"2026-02-10T21:27:06.458906Z","end":"2026-02-10T21:27:06.855974Z","steps":["trace[1263520090] 'process raft request' (duration: 396.738519ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:27:06.856086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:27:06.458887Z","time spent":"397.147279ms","remote":"127.0.0.1:44034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T21:27:07.350413Z","caller":"traceutil/trace.go:171","msg":"trace[1640016251] transaction","detail":"{read_only:false; response_revision:853; number_of_response:1; }","duration":"488.963562ms","start":"2026-02-10T21:27:06.861434Z","end":"2026-02-10T21:27:07.350398Z","steps":["trace[1640016251] 'process raft request' (duration: 488.626103ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:27:07.350494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:27:06.861422Z","time spent":"489.028723ms","remote":"127.0.0.1:44034","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-10T21:27:07.784446Z","caller":"traceutil/trace.go:171","msg":"trace[1775999481] transaction","detail":"{read_only:false; response_revision:854; number_of_response:1; }","duration":"389.978859ms","start":"2026-02-10T21:27:07.394448Z","end":"2026-02-10T21:27:07.784427Z","steps":["trace[1775999481] 'process raft request' (duration: 311.954871ms)","trace[1775999481] 'compare' (duration: 77.960117ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:27:07.784539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:27:07.394439Z","time spent":"390.051951ms","remote":"127.0.0.1:44034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T21:27:13.117717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.663076ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T21:27:13.117816Z","caller":"traceutil/trace.go:171","msg":"trace[402965659] linearizableReadLoop","detail":"{readStateIndex:902; appliedIndex:901; }","duration":"302.583827ms","start":"2026-02-10T21:27:12.815199Z","end":"2026-02-10T21:27:13.117783Z","steps":["trace[402965659] 'read index received' (duration: 54.766717ms)","trace[402965659] 'applied index is now lower than readState.Index' (duration: 247.81652ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:27:13.117877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.681459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T21:27:13.117901Z","caller":"traceutil/trace.go:171","msg":"trace[800020533] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:868; }","duration":"302.734091ms","start":"2026-02-10T21:27:12.815163Z","end":"2026-02-10T21:27:13.117897Z","steps":["trace[800020533] 'agreement among raft nodes before linearized reading' (duration: 302.668389ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:27:13.117917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:27:12.815148Z","time spent":"302.765261ms","remote":"127.0.0.1:43790","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-10T21:27:13.118011Z","caller":"traceutil/trace.go:171","msg":"trace[1516364226] transaction","detail":"{read_only:false; response_revision:868; number_of_response:1; }","duration":"328.656807ms","start":"2026-02-10T21:27:12.789349Z","end":"2026-02-10T21:27:13.118005Z","steps":["trace[1516364226] 'process raft request' (duration: 80.654693ms)","trace[1516364226] 'compare' (duration: 247.452171ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:27:13.118041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:27:12.789323Z","time spent":"328.704449ms","remote":"127.0.0.1:43804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T21:27:13.597686Z","caller":"traceutil/trace.go:171","msg":"trace[536614903] transaction","detail":"{read_only:false; response_revision:869; number_of_response:1; }","duration":"230.958427ms","start":"2026-02-10T21:27:13.366708Z","end":"2026-02-10T21:27:13.597667Z","steps":["trace[536614903] 'process raft request' (duration: 230.842964ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:27:14.054978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.071213ms","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-10T21:27:14.055039Z","caller":"traceutil/trace.go:171","msg":"trace[142896689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:870; }","duration":"137.157154ms","start":"2026-02-10T21:27:13.917867Z","end":"2026-02-10T21:27:14.055024Z","steps":["trace[142896689] 'range keys from in-memory index tree' (duration: 136.97142ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:27:14.055233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.446928ms","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-10T21:27:14.055253Z","caller":"traceutil/trace.go:171","msg":"trace[2047810614] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:870; }","duration":"138.488279ms","start":"2026-02-10T21:27:13.916758Z","end":"2026-02-10T21:27:14.055246Z","steps":["trace[2047810614] 'range keys from in-memory index tree' (duration: 138.406877ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:27:14.055366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.544116ms","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-10T21:27:14.055384Z","caller":"traceutil/trace.go:171","msg":"trace[818562657] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:870; }","duration":"137.582007ms","start":"2026-02-10T21:27:13.917795Z","end":"2026-02-10T21:27:14.055377Z","steps":["trace[818562657] 'range keys from in-memory index tree' (duration: 137.488405ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:27:14.364457Z","caller":"traceutil/trace.go:171","msg":"trace[1418838004] transaction","detail":"{read_only:false; response_revision:871; number_of_response:1; }","duration":"305.739485ms","start":"2026-02-10T21:27:14.058694Z","end":"2026-02-10T21:27:14.364433Z","steps":["trace[1418838004] 'process raft request' (duration: 305.609572ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:27:14.364598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:27:14.058679Z","time spent":"305.845669ms","remote":"127.0.0.1:44034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T21:27:14.714115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.575219ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T21:27:14.714308Z","caller":"traceutil/trace.go:171","msg":"trace[742670884] transaction","detail":"{read_only:false; response_revision:872; number_of_response:1; }","duration":"652.939887ms","start":"2026-02-10T21:27:14.061349Z","end":"2026-02-10T21:27:14.714288Z","steps":["trace[742670884] 'process raft request' (duration: 424.116442ms)","trace[742670884] 'compare' (duration: 228.444355ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:27:14.714325Z","caller":"traceutil/trace.go:171","msg":"trace[1843643940] transaction","detail":"{read_only:false; response_revision:873; number_of_response:1; }","duration":"649.850479ms","start":"2026-02-10T21:27:14.064458Z","end":"2026-02-10T21:27:14.714308Z","steps":["trace[1843643940] 'process raft request' (duration: 649.784818ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:27:14.714401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:27:14.061333Z","time spent":"653.015338ms","remote":"127.0.0.1:44034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T21:27:14.714409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:27:14.064449Z","time spent":"649.914952ms","remote":"127.0.0.1:44034","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-10T21:27:20.653731Z","caller":"traceutil/trace.go:171","msg":"trace[1717099144] transaction","detail":"{read_only:false; response_revision:888; number_of_response:1; }","duration":"255.950052ms","start":"2026-02-10T21:27:20.397764Z","end":"2026-02-10T21:27:20.653714Z","steps":["trace[1717099144] 'process raft request' (duration: 255.85965ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:27:22.270038Z","caller":"traceutil/trace.go:171","msg":"trace[449321956] transaction","detail":"{read_only:false; response_revision:892; number_of_response:1; }","duration":"367.387685ms","start":"2026-02-10T21:27:21.902629Z","end":"2026-02-10T21:27:22.270016Z","steps":["trace[449321956] 'process raft request' (duration: 367.142379ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:27:22.270533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:27:21.90262Z","time spent":"367.600311ms","remote":"127.0.0.1:44034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T21:27:26.800267Z","caller":"traceutil/trace.go:171","msg":"trace[1585851] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"103.602988ms","start":"2026-02-10T21:27:26.696645Z","end":"2026-02-10T21:27:26.800248Z","steps":["trace[1585851] 'process raft request' (duration: 103.29447ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:27:27.752035Z","caller":"traceutil/trace.go:171","msg":"trace[51995136] linearizableReadLoop","detail":"{readStateIndex:959; appliedIndex:958; }","duration":"116.867409ms","start":"2026-02-10T21:27:27.635145Z","end":"2026-02-10T21:27:27.752013Z","steps":["trace[51995136] 'read index received' (duration: 116.679014ms)","trace[51995136] 'applied index is now lower than readState.Index' (duration: 187.465µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:27:27.752251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.084134ms","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-10T21:27:27.752285Z","caller":"traceutil/trace.go:171","msg":"trace[1679578391] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:923; }","duration":"117.151847ms","start":"2026-02-10T21:27:27.635124Z","end":"2026-02-10T21:27:27.752275Z","steps":["trace[1679578391] 'agreement among raft nodes before linearized reading' (duration: 116.970432ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:27:27.752631Z","caller":"traceutil/trace.go:171","msg":"trace[2005229012] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"139.590646ms","start":"2026-02-10T21:27:27.613029Z","end":"2026-02-10T21:27:27.752619Z","steps":["trace[2005229012] 'process raft request' (duration: 138.850758ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:27:28.211317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.038393ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-02-10T21:27:34.852031Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15490021282621999204,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T21:27:35.102807Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.241255336s","expected-duration":"1s"} {"level":"info","ts":"2026-02-10T21:27:35.219611Z","caller":"traceutil/trace.go:171","msg":"trace[188696904] linearizableReadLoop","detail":"{readStateIndex:1005; appliedIndex:1004; }","duration":"868.378673ms","start":"2026-02-10T21:27:34.351214Z","end":"2026-02-10T21:27:35.219593Z","steps":["trace[188696904] 'read index received' (duration: 868.253709ms)","trace[188696904] 'applied index is now lower than readState.Index' (duration: 124.224µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:27:35.21967Z","caller":"traceutil/trace.go:171","msg":"trace[2054002313] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"1.35820685s","start":"2026-02-10T21:27:33.861456Z","end":"2026-02-10T21:27:35.219663Z","steps":["trace[2054002313] 'process raft request' (duration: 1.358047546s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:27:35.219754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:27:33.861429Z","time spent":"1.358255972s","remote":"127.0.0.1:44034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T21:27:35.219915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.377812ms","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-10T21:27:35.219967Z","caller":"traceutil/trace.go:171","msg":"trace[256563444] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:967; }","duration":"384.463543ms","start":"2026-02-10T21:27:34.835489Z","end":"2026-02-10T21:27:35.219952Z","steps":["trace[256563444] 'agreement among raft nodes before linearized reading' (duration: 384.32592ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:27:35.219968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.774032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T21:27:35.219995Z","caller":"traceutil/trace.go:171","msg":"trace[430090860] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:967; }","duration":"132.817233ms","start":"2026-02-10T21:27:35.087169Z","end":"2026-02-10T21:27:35.219987Z","steps":["trace[430090860] 'agreement among raft nodes before linearized reading' (duration: 132.777432ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:27:35.219998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:27:34.835473Z","time spent":"384.515655ms","remote":"127.0.0.1:44034","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-10T21:27:35.220121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.059211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-10T21:27:35.220132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"868.918755ms","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-10T21:27:35.220139Z","caller":"traceutil/trace.go:171","msg":"trace[1719823545] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:967; }","duration":"193.101461ms","start":"2026-02-10T21:27:35.027031Z","end":"2026-02-10T21:27:35.220133Z","steps":["trace[1719823545] 'agreement among raft nodes before linearized reading' (duration: 193.0704ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:27:35.220156Z","caller":"traceutil/trace.go:171","msg":"trace[1833963193] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:967; }","duration":"868.975606ms","start":"2026-02-10T21:27:34.351173Z","end":"2026-02-10T21:27:35.220148Z","steps":["trace[1833963193] 'agreement among raft nodes before linearized reading' (duration: 868.897805ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:27:35.220175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:27:34.351153Z","time spent":"869.016747ms","remote":"127.0.0.1:44034","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-10T21:27:35.220265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.810183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-10T21:27:35.220285Z","caller":"traceutil/trace.go:171","msg":"trace[1222093234] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:967; }","duration":"123.852724ms","start":"2026-02-10T21:27:35.096425Z","end":"2026-02-10T21:27:35.220278Z","steps":["trace[1222093234] 'agreement among raft nodes before linearized reading' (duration: 123.819244ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:27:35.220266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.701839ms","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-10T21:27:35.220894Z","caller":"traceutil/trace.go:171","msg":"trace[1712568766] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:967; }","duration":"326.343214ms","start":"2026-02-10T21:27:34.894537Z","end":"2026-02-10T21:27:35.220881Z","steps":["trace[1712568766] 'agreement among raft nodes before linearized reading' (duration: 325.690759ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:27:35.220924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:27:34.894527Z","time spent":"326.387485ms","remote":"127.0.0.1:44034","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-10T21:27:35.220309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.515108ms","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-10T21:27:35.221463Z","caller":"traceutil/trace.go:171","msg":"trace[300040585] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:967; }","duration":"377.690895ms","start":"2026-02-10T21:27:34.843761Z","end":"2026-02-10T21:27:35.221452Z","steps":["trace[300040585] 'agreement among raft nodes before linearized reading' (duration: 376.515678ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:27:35.221492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:27:34.843752Z","time spent":"377.730646ms","remote":"127.0.0.1:44034","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-10T21:27:38.291469Z","caller":"traceutil/trace.go:171","msg":"trace[302016333] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"450.309081ms","start":"2026-02-10T21:27:37.841133Z","end":"2026-02-10T21:27:38.291442Z","steps":["trace[302016333] 'process raft request' (duration: 420.634742ms)","trace[302016333] 'compare' (duration: 29.518236ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:27:38.29189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:27:37.841119Z","time spent":"450.650889ms","remote":"127.0.0.1:44034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":518,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T21:27:38.311299Z","caller":"traceutil/trace.go:171","msg":"trace[1523667232] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"281.663906ms","start":"2026-02-10T21:27:38.029619Z","end":"2026-02-10T21:27:38.311283Z","steps":["trace[1523667232] 'process raft request' (duration: 281.505853ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:27:38.574337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.091746ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-10T21:27:38.575111Z","caller":"traceutil/trace.go:171","msg":"trace[1349984622] linearizableReadLoop","detail":"{readStateIndex:1031; appliedIndex:1028; }","duration":"433.774556ms","start":"2026-02-10T21:27:38.141308Z","end":"2026-02-10T21:27:38.575083Z","steps":["trace[1349984622] 'read index received' (duration: 120.61797ms)","trace[1349984622] 'applied index is now lower than readState.Index' (duration: 313.155086ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:27:38.575335Z","caller":"traceutil/trace.go:171","msg":"trace[1569860571] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"277.169202ms","start":"2026-02-10T21:27:38.298158Z","end":"2026-02-10T21:27:38.575327Z","steps":["trace[1569860571] 'process raft request' (duration: 276.269942ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:27:38.725257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.060091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-02-10T21:27:38.725315Z","caller":"traceutil/trace.go:171","msg":"trace[304167473] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:993; }","duration":"427.160934ms","start":"2026-02-10T21:27:38.298144Z","end":"2026-02-10T21:27:38.725305Z","steps":["trace[304167473] 'agreement among raft nodes before linearized reading' (duration: 277.176413ms)","trace[304167473] 'range keys from in-memory index tree' (duration: 149.847318ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:27:38.725289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.957442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:534"} {"level":"warn","ts":"2026-02-10T21:27:38.725339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:27:38.298128Z","time spent":"427.205385ms","remote":"127.0.0.1:44034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":556,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-02-10T21:27:38.725357Z","caller":"traceutil/trace.go:171","msg":"trace[1049486425] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:993; }","duration":"584.035524ms","start":"2026-02-10T21:27:38.141303Z","end":"2026-02-10T21:27:38.725338Z","steps":["trace[1049486425] 'agreement among raft nodes before linearized reading' (duration: 433.876289ms)","trace[1049486425] 'range keys from in-memory index tree' (duration: 150.008282ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:27:38.725391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:27:38.141244Z","time spent":"584.140417ms","remote":"127.0.0.1:44034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":557,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-02-10T21:27:52.849125Z","caller":"traceutil/trace.go:171","msg":"trace[240765670] transaction","detail":"{read_only:false; response_revision:1056; number_of_response:1; }","duration":"131.137054ms","start":"2026-02-10T21:27:52.717956Z","end":"2026-02-10T21:27:52.849093Z","steps":["trace[240765670] 'process raft request' (duration: 130.95246ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:28:53.3851Z","caller":"traceutil/trace.go:171","msg":"trace[300566766] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"118.798202ms","start":"2026-02-10T21:28:53.266277Z","end":"2026-02-10T21:28:53.385075Z","steps":["trace[300566766] 'process raft request' (duration: 118.675339ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:30:44.371878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.008017ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T21:30:44.372129Z","caller":"traceutil/trace.go:171","msg":"trace[1915580246] transaction","detail":"{read_only:false; response_revision:1785; number_of_response:1; }","duration":"158.732449ms","start":"2026-02-10T21:30:44.213373Z","end":"2026-02-10T21:30:44.372106Z","steps":["trace[1915580246] 'process raft request' (duration: 36.171521ms)","trace[1915580246] 'compare' (duration: 121.898644ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:30:44.374316Z","caller":"traceutil/trace.go:171","msg":"trace[1105290729] transaction","detail":"{read_only:false; response_revision:1786; number_of_response:1; }","duration":"158.336021ms","start":"2026-02-10T21:30:44.215962Z","end":"2026-02-10T21:30:44.374298Z","steps":["trace[1105290729] 'process raft request' (duration: 156.40605ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:30:52.301183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.155136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-02-10T21:30:52.30122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.567475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-02-10T21:30:52.301269Z","caller":"traceutil/trace.go:171","msg":"trace[1524224360] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1818; }","duration":"127.277908ms","start":"2026-02-10T21:30:52.173975Z","end":"2026-02-10T21:30:52.301253Z","steps":["trace[1524224360] 'range keys from in-memory index tree' (duration: 127.009592ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:30:52.30128Z","caller":"traceutil/trace.go:171","msg":"trace[515717436] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1818; }","duration":"325.664427ms","start":"2026-02-10T21:30:51.975602Z","end":"2026-02-10T21:30:52.301267Z","steps":["trace[515717436] 'range keys from in-memory index tree' (duration: 325.441982ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:30:52.301471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:30:51.975588Z","time spent":"325.871681ms","remote":"127.0.0.1:44034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":556,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "}