{"level":"warn","ts":"2026-02-03T12:58:09.186738Z","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-03T12:58:09.186908Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.209:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.209:2380","--initial-cluster=instance=https://199.204.45.209:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.209:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.209: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-03T12:58:09.18698Z","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-03T12:58:09.186989Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.209:2380"]} {"level":"info","ts":"2026-02-03T12:58:09.187008Z","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-03T12:58:09.187561Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.209:2379"]} {"level":"info","ts":"2026-02-03T12:58:09.187641Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.209:2380"],"listen-peer-urls":["https://199.204.45.209:2380"],"advertise-client-urls":["https://199.204.45.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.209: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-03T12:58:09.193449Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.409096ms"} {"level":"info","ts":"2026-02-03T12:58:09.199386Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"adfb641115bf6cbd","cluster-id":"3da6b677d4b80c6"} {"level":"info","ts":"2026-02-03T12:58:09.19945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=()"} {"level":"info","ts":"2026-02-03T12:58:09.199465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became follower at term 0"} {"level":"info","ts":"2026-02-03T12:58:09.199484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft adfb641115bf6cbd [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-03T12:58:09.19949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became follower at term 1"} {"level":"info","ts":"2026-02-03T12:58:09.199521Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=(12536724012257995965)"} {"level":"warn","ts":"2026-02-03T12:58:09.213943Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-03T12:58:09.246073Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-03T12:58:09.248824Z","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-03T12:58:09.25073Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"adfb641115bf6cbd","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-03T12:58:09.252524Z","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-03T12:58:09.25266Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"adfb641115bf6cbd","initial-advertise-peer-urls":["https://199.204.45.209:2380"],"listen-peer-urls":["https://199.204.45.209:2380"],"advertise-client-urls":["https://199.204.45.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-03T12:58:09.252677Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-03T12:58:09.2573Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"adfb641115bf6cbd","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-03T12:58:09.25742Z","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-03T12:58:09.257466Z","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-03T12:58:09.257472Z","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-03T12:58:09.261117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=(12536724012257995965)"} {"level":"info","ts":"2026-02-03T12:58:09.261178Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3da6b677d4b80c6","local-member-id":"adfb641115bf6cbd","added-peer-id":"adfb641115bf6cbd","added-peer-peer-urls":["https://199.204.45.209:2380"]} {"level":"info","ts":"2026-02-03T12:58:09.261204Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.209:2380"} {"level":"info","ts":"2026-02-03T12:58:09.261209Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.209:2380"} {"level":"info","ts":"2026-02-03T12:58:09.901251Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd is starting a new election at term 1"} {"level":"info","ts":"2026-02-03T12:58:09.901398Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became pre-candidate at term 1"} {"level":"info","ts":"2026-02-03T12:58:09.901466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd received MsgPreVoteResp from adfb641115bf6cbd at term 1"} {"level":"info","ts":"2026-02-03T12:58:09.901515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became candidate at term 2"} {"level":"info","ts":"2026-02-03T12:58:09.901564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd received MsgVoteResp from adfb641115bf6cbd at term 2"} {"level":"info","ts":"2026-02-03T12:58:09.90165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became leader at term 2"} {"level":"info","ts":"2026-02-03T12:58:09.901712Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: adfb641115bf6cbd elected leader adfb641115bf6cbd at term 2"} {"level":"info","ts":"2026-02-03T12:58:09.903446Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-03T12:58:09.904179Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"adfb641115bf6cbd","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.209:2379]}","request-path":"/0/members/adfb641115bf6cbd/attributes","cluster-id":"3da6b677d4b80c6","publish-timeout":"7s"} {"level":"info","ts":"2026-02-03T12:58:09.904465Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-03T12:58:09.9083Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-03T12:58:09.909957Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3da6b677d4b80c6","local-member-id":"adfb641115bf6cbd","cluster-version":"3.5"} {"level":"info","ts":"2026-02-03T12:58:09.914128Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-03T12:58:09.914194Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-03T12:58:09.909977Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-03T12:58:09.914056Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-03T12:58:09.915875Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-03T12:58:09.91584Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.209:2379"} {"level":"warn","ts":"2026-02-03T12:58:19.920953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.806887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-03T12:58:19.92106Z","caller":"traceutil/trace.go:171","msg":"trace[1589578755] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:376; }","duration":"320.94496ms","start":"2026-02-03T12:58:19.60009Z","end":"2026-02-03T12:58:19.921035Z","steps":["trace[1589578755] 'range keys from in-memory index tree' (duration: 320.752096ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T12:58:19.921134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T12:58:19.600065Z","time spent":"321.053053ms","remote":"127.0.0.1:37466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"info","ts":"2026-02-03T12:58:20.257299Z","caller":"traceutil/trace.go:171","msg":"trace[302290680] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"323.270471ms","start":"2026-02-03T12:58:19.934004Z","end":"2026-02-03T12:58:20.257274Z","steps":["trace[302290680] 'process raft request' (duration: 323.141167ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T12:58:20.257839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T12:58:19.933984Z","time spent":"323.387513ms","remote":"127.0.0.1:37534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-03T12:58:20.771155Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835590603331056208,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-03T12:58:20.869796Z","caller":"traceutil/trace.go:171","msg":"trace[1834282261] linearizableReadLoop","detail":"{readStateIndex:389; appliedIndex:387; }","duration":"599.287358ms","start":"2026-02-03T12:58:20.27049Z","end":"2026-02-03T12:58:20.869777Z","steps":["trace[1834282261] 'read index received' (duration: 599.110894ms)","trace[1834282261] 'applied index is now lower than readState.Index' (duration: 175.834µs)"],"step_count":2} {"level":"warn","ts":"2026-02-03T12:58:20.869951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.445861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-03T12:58:20.869985Z","caller":"traceutil/trace.go:171","msg":"trace[548925655] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:379; }","duration":"599.513933ms","start":"2026-02-03T12:58:20.270463Z","end":"2026-02-03T12:58:20.869977Z","steps":["trace[548925655] 'agreement among raft nodes before linearized reading' (duration: 599.434061ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T12:58:20.870008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T12:58:20.27045Z","time spent":"599.551804ms","remote":"127.0.0.1:37534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-03T12:58:20.870973Z","caller":"traceutil/trace.go:171","msg":"trace[1779349175] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"935.988936ms","start":"2026-02-03T12:58:19.934926Z","end":"2026-02-03T12:58:20.870915Z","steps":["trace[1779349175] 'process raft request' (duration: 934.719428ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T12:58:20.871047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T12:58:19.934915Z","time spent":"936.085797ms","remote":"127.0.0.1:37534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-03T12:58:20.872561Z","caller":"traceutil/trace.go:171","msg":"trace[672933145] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"936.059587ms","start":"2026-02-03T12:58:19.936479Z","end":"2026-02-03T12:58:20.872538Z","steps":["trace[672933145] 'process raft request' (duration: 933.271577ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T12:58:20.872624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T12:58:19.936471Z","time spent":"936.117518ms","remote":"127.0.0.1:37458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3505,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-03T12:58:43.497062Z","caller":"traceutil/trace.go:171","msg":"trace[1900201220] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"105.198441ms","start":"2026-02-03T12:58:43.391847Z","end":"2026-02-03T12:58:43.497045Z","steps":["trace[1900201220] 'process raft request' (duration: 96.015335ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T12:58:48.780751Z","caller":"traceutil/trace.go:171","msg":"trace[1402899137] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"426.735644ms","start":"2026-02-03T12:58:48.353983Z","end":"2026-02-03T12:58:48.780719Z","steps":["trace[1402899137] 'process raft request' (duration: 426.514379ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T12:58:48.780945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T12:58:48.353971Z","time spent":"426.865079ms","remote":"127.0.0.1:37458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-03T12:58:48.781652Z","caller":"traceutil/trace.go:171","msg":"trace[235794265] linearizableReadLoop","detail":"{readStateIndex:553; appliedIndex:553; }","duration":"373.319212ms","start":"2026-02-03T12:58:48.40832Z","end":"2026-02-03T12:58:48.781639Z","steps":["trace[235794265] 'read index received' (duration: 373.314001ms)","trace[235794265] 'applied index is now lower than readState.Index' (duration: 4.161µs)"],"step_count":2} {"level":"warn","ts":"2026-02-03T12:58:48.781847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.507155ms","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-03T12:58:48.781885Z","caller":"traceutil/trace.go:171","msg":"trace[849881890] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:536; }","duration":"373.615848ms","start":"2026-02-03T12:58:48.408259Z","end":"2026-02-03T12:58:48.781874Z","steps":["trace[849881890] 'agreement among raft nodes before linearized reading' (duration: 373.463384ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T12:58:48.781916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T12:58:48.408241Z","time spent":"373.667969ms","remote":"127.0.0.1:37534","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":"warn","ts":"2026-02-03T12:58:48.939769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.06395ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-03T12:58:48.940018Z","caller":"traceutil/trace.go:171","msg":"trace[517678700] linearizableReadLoop","detail":"{readStateIndex:554; appliedIndex:553; }","duration":"158.308867ms","start":"2026-02-03T12:58:48.781692Z","end":"2026-02-03T12:58:48.94Z","steps":["trace[517678700] 'read index received' (duration: 15.850849ms)","trace[517678700] 'applied index is now lower than readState.Index' (duration: 142.457038ms)"],"step_count":2} {"level":"warn","ts":"2026-02-03T12:58:48.940226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.295076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-03T12:58:48.94025Z","caller":"traceutil/trace.go:171","msg":"trace[1651312271] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:536; }","duration":"228.376547ms","start":"2026-02-03T12:58:48.711865Z","end":"2026-02-03T12:58:48.940242Z","steps":["trace[1651312271] 'agreement among raft nodes before linearized reading' (duration: 228.321466ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T12:58:48.940995Z","caller":"traceutil/trace.go:171","msg":"trace[367256765] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"150.696326ms","start":"2026-02-03T12:58:48.790283Z","end":"2026-02-03T12:58:48.94098Z","steps":["trace[367256765] 'process raft request' (duration: 149.625652ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T12:58:50.824631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.890583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-03T12:58:50.824723Z","caller":"traceutil/trace.go:171","msg":"trace[1810246524] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:548; }","duration":"111.073648ms","start":"2026-02-03T12:58:50.71363Z","end":"2026-02-03T12:58:50.824703Z","steps":["trace[1810246524] 'range keys from in-memory index tree' (duration: 110.790371ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T12:58:52.615329Z","caller":"traceutil/trace.go:171","msg":"trace[248291777] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"159.705698ms","start":"2026-02-03T12:58:52.455591Z","end":"2026-02-03T12:58:52.615297Z","steps":["trace[248291777] 'process raft request' (duration: 135.292096ms)","trace[248291777] 'compare' (duration: 24.169487ms)"],"step_count":2} {"level":"info","ts":"2026-02-03T12:58:52.686188Z","caller":"traceutil/trace.go:171","msg":"trace[2086527885] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"113.616082ms","start":"2026-02-03T12:58:52.572558Z","end":"2026-02-03T12:58:52.686174Z","steps":["trace[2086527885] 'process raft request' (duration: 113.241623ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T12:58:52.686211Z","caller":"traceutil/trace.go:171","msg":"trace[658007563] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"115.207336ms","start":"2026-02-03T12:58:52.570943Z","end":"2026-02-03T12:58:52.686151Z","steps":["trace[658007563] 'process raft request' (duration: 114.819687ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T12:58:52.68641Z","caller":"traceutil/trace.go:171","msg":"trace[390234621] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"177.48516ms","start":"2026-02-03T12:58:52.50892Z","end":"2026-02-03T12:58:52.686405Z","steps":["trace[390234621] 'process raft request' (duration: 176.770204ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T12:58:52.840415Z","caller":"traceutil/trace.go:171","msg":"trace[2016344022] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"126.825976ms","start":"2026-02-03T12:58:52.713563Z","end":"2026-02-03T12:58:52.840389Z","steps":["trace[2016344022] 'process raft request' (duration: 100.260947ms)","trace[2016344022] 'compare' (duration: 26.356945ms)"],"step_count":2} {"level":"info","ts":"2026-02-03T12:58:52.840711Z","caller":"traceutil/trace.go:171","msg":"trace[1443727319] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"122.36061ms","start":"2026-02-03T12:58:52.71834Z","end":"2026-02-03T12:58:52.840701Z","steps":["trace[1443727319] 'process raft request' (duration: 121.996482ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T12:59:01.889445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.447133ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-03T12:59:01.889672Z","caller":"traceutil/trace.go:171","msg":"trace[901401696] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"323.038155ms","start":"2026-02-03T12:59:01.566617Z","end":"2026-02-03T12:59:01.889655Z","steps":["trace[901401696] 'process raft request' (duration: 114.325116ms)","trace[901401696] 'compare' (duration: 208.344741ms)"],"step_count":2} {"level":"warn","ts":"2026-02-03T12:59:01.889758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T12:59:01.566599Z","time spent":"323.112497ms","remote":"127.0.0.1:37458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4833,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-03T12:59:02.212276Z","caller":"traceutil/trace.go:171","msg":"trace[2060625078] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"317.104788ms","start":"2026-02-03T12:59:01.895148Z","end":"2026-02-03T12:59:02.212253Z","steps":["trace[2060625078] 'process raft request' (duration: 316.910023ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T12:59:02.212317Z","caller":"traceutil/trace.go:171","msg":"trace[1795460761] linearizableReadLoop","detail":"{readStateIndex:708; appliedIndex:707; }","duration":"314.967541ms","start":"2026-02-03T12:59:01.897326Z","end":"2026-02-03T12:59:02.212293Z","steps":["trace[1795460761] 'read index received' (duration: 29.382868ms)","trace[1795460761] 'applied index is now lower than readState.Index' (duration: 285.583813ms)"],"step_count":2} {"level":"warn","ts":"2026-02-03T12:59:02.212436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T12:59:01.895137Z","time spent":"317.194279ms","remote":"127.0.0.1:37536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1292,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-03T12:59:02.212534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.182276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-mj6zg\" ","response":"range_response_count:1 size:4697"} {"level":"info","ts":"2026-02-03T12:59:02.212567Z","caller":"traceutil/trace.go:171","msg":"trace[2144525496] range","detail":"{range_begin:/registry/pods/kube-system/coredns-5dd5756b68-mj6zg; range_end:; response_count:1; response_revision:688; }","duration":"315.234047ms","start":"2026-02-03T12:59:01.897323Z","end":"2026-02-03T12:59:02.212557Z","steps":["trace[2144525496] 'agreement among raft nodes before linearized reading' (duration: 315.067643ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T12:59:02.212601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T12:59:01.897302Z","time spent":"315.290939ms","remote":"127.0.0.1:37458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":4720,"request content":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-mj6zg\" "} {"level":"info","ts":"2026-02-03T12:59:02.212859Z","caller":"traceutil/trace.go:171","msg":"trace[1330725683] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"313.257825ms","start":"2026-02-03T12:59:01.899566Z","end":"2026-02-03T12:59:02.212824Z","steps":["trace[1330725683] 'process raft request' (duration: 312.681582ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T12:59:02.212937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T12:59:01.89956Z","time spent":"313.325606ms","remote":"127.0.0.1:37734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3866,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-03T12:59:02.212866Z","caller":"traceutil/trace.go:171","msg":"trace[1266978311] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"314.42225ms","start":"2026-02-03T12:59:01.898437Z","end":"2026-02-03T12:59:02.212859Z","steps":["trace[1266978311] 'process raft request' (duration: 313.757486ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T12:59:02.212992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T12:59:01.89843Z","time spent":"314.545793ms","remote":"127.0.0.1:37432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":783,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-03T12:59:04.206362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.716574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-03T12:59:04.206428Z","caller":"traceutil/trace.go:171","msg":"trace[889796939] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:716; }","duration":"497.814906ms","start":"2026-02-03T12:59:03.708599Z","end":"2026-02-03T12:59:04.206414Z","steps":["trace[889796939] 'range keys from in-memory index tree' (duration: 497.671484ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T12:59:04.206454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T12:59:03.708587Z","time spent":"497.861157ms","remote":"127.0.0.1:37294","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-03T12:59:04.206811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.808007ms","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-03T12:59:04.20683Z","caller":"traceutil/trace.go:171","msg":"trace[895883119] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:716; }","duration":"277.859217ms","start":"2026-02-03T12:59:03.928965Z","end":"2026-02-03T12:59:04.206824Z","steps":["trace[895883119] 'range keys from in-memory index tree' (duration: 277.722465ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T12:59:04.80449Z","caller":"traceutil/trace.go:171","msg":"trace[756905333] transaction","detail":"{read_only:false; response_revision:717; number_of_response:1; }","duration":"594.113187ms","start":"2026-02-03T12:59:04.210362Z","end":"2026-02-03T12:59:04.804475Z","steps":["trace[756905333] 'process raft request' (duration: 593.839921ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T12:59:04.804573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T12:59:04.210349Z","time spent":"594.177609ms","remote":"127.0.0.1:37534","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-03T12:59:08.92822Z","caller":"traceutil/trace.go:171","msg":"trace[1780754202] linearizableReadLoop","detail":"{readStateIndex:753; appliedIndex:752; }","duration":"108.442412ms","start":"2026-02-03T12:59:08.819754Z","end":"2026-02-03T12:59:08.928197Z","steps":["trace[1780754202] 'read index received' (duration: 54.18323ms)","trace[1780754202] 'applied index is now lower than readState.Index' (duration: 54.258062ms)"],"step_count":2} {"level":"warn","ts":"2026-02-03T12:59:08.9284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.631487ms","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-03T12:59:08.928426Z","caller":"traceutil/trace.go:171","msg":"trace[418295175] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:728; }","duration":"108.707928ms","start":"2026-02-03T12:59:08.819712Z","end":"2026-02-03T12:59:08.92842Z","steps":["trace[418295175] 'agreement among raft nodes before linearized reading' (duration: 108.575895ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T12:59:09.38501Z","caller":"traceutil/trace.go:171","msg":"trace[352567259] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"128.808599ms","start":"2026-02-03T12:59:09.256184Z","end":"2026-02-03T12:59:09.384992Z","steps":["trace[352567259] 'process raft request' (duration: 112.669705ms)","trace[352567259] 'compare' (duration: 15.737945ms)"],"step_count":2} {"level":"info","ts":"2026-02-03T12:59:17.72211Z","caller":"traceutil/trace.go:171","msg":"trace[120612257] linearizableReadLoop","detail":"{readStateIndex:786; appliedIndex:785; }","duration":"306.258288ms","start":"2026-02-03T12:59:17.415837Z","end":"2026-02-03T12:59:17.722096Z","steps":["trace[120612257] 'read index received' (duration: 306.098875ms)","trace[120612257] 'applied index is now lower than readState.Index' (duration: 158.823µs)"],"step_count":2} {"level":"info","ts":"2026-02-03T12:59:17.722316Z","caller":"traceutil/trace.go:171","msg":"trace[1330554637] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"370.280714ms","start":"2026-02-03T12:59:17.352029Z","end":"2026-02-03T12:59:17.72231Z","steps":["trace[1330554637] 'process raft request' (duration: 369.942086ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T12:59:17.722388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T12:59:17.352017Z","time spent":"370.317784ms","remote":"127.0.0.1:37534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-03T12:59:17.722508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.673487ms","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-03T12:59:17.722524Z","caller":"traceutil/trace.go:171","msg":"trace[966616073] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:759; }","duration":"306.714018ms","start":"2026-02-03T12:59:17.415805Z","end":"2026-02-03T12:59:17.722519Z","steps":["trace[966616073] 'agreement among raft nodes before linearized reading' (duration: 306.659907ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T12:59:17.722538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T12:59:17.41579Z","time spent":"306.742968ms","remote":"127.0.0.1:37534","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-03T12:59:17.722613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.554631ms","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-03T12:59:17.722625Z","caller":"traceutil/trace.go:171","msg":"trace[91869623] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:759; }","duration":"274.590851ms","start":"2026-02-03T12:59:17.44803Z","end":"2026-02-03T12:59:17.722621Z","steps":["trace[91869623] 'agreement among raft nodes before linearized reading' (duration: 274.558461ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T12:59:17.723049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.542815ms","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-03T12:59:17.72307Z","caller":"traceutil/trace.go:171","msg":"trace[1280366101] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:759; }","duration":"195.581777ms","start":"2026-02-03T12:59:17.527483Z","end":"2026-02-03T12:59:17.723065Z","steps":["trace[1280366101] 'agreement among raft nodes before linearized reading' (duration: 195.535006ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T12:59:17.723134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.315526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-03T12:59:17.723151Z","caller":"traceutil/trace.go:171","msg":"trace[280909387] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:759; }","duration":"264.359837ms","start":"2026-02-03T12:59:17.458786Z","end":"2026-02-03T12:59:17.723146Z","steps":["trace[280909387] 'agreement among raft nodes before linearized reading' (duration: 264.334546ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T12:59:29.967433Z","caller":"traceutil/trace.go:171","msg":"trace[2045498148] linearizableReadLoop","detail":"{readStateIndex:822; appliedIndex:821; }","duration":"165.974045ms","start":"2026-02-03T12:59:29.801436Z","end":"2026-02-03T12:59:29.96741Z","steps":["trace[2045498148] 'read index received' (duration: 165.783021ms)","trace[2045498148] 'applied index is now lower than readState.Index' (duration: 190.164µs)"],"step_count":2} {"level":"info","ts":"2026-02-03T12:59:29.968792Z","caller":"traceutil/trace.go:171","msg":"trace[872437605] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"202.498088ms","start":"2026-02-03T12:59:29.766276Z","end":"2026-02-03T12:59:29.968774Z","steps":["trace[872437605] 'process raft request' (duration: 201.000355ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T12:59:29.969156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.712504ms","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-03T12:59:29.969196Z","caller":"traceutil/trace.go:171","msg":"trace[1955920668] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:792; }","duration":"167.805576ms","start":"2026-02-03T12:59:29.801377Z","end":"2026-02-03T12:59:29.969182Z","steps":["trace[1955920668] 'agreement among raft nodes before linearized reading' (duration: 167.667983ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T12:59:29.969546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.521575ms","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-03T12:59:29.969585Z","caller":"traceutil/trace.go:171","msg":"trace[888831899] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:792; }","duration":"144.616707ms","start":"2026-02-03T12:59:29.824959Z","end":"2026-02-03T12:59:29.969576Z","steps":["trace[888831899] 'agreement among raft nodes before linearized reading' (duration: 144.503365ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T12:59:29.970409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.5314ms","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-03T12:59:29.970455Z","caller":"traceutil/trace.go:171","msg":"trace[1193919987] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:792; }","duration":"136.596971ms","start":"2026-02-03T12:59:29.833848Z","end":"2026-02-03T12:59:29.970445Z","steps":["trace[1193919987] 'agreement among raft nodes before linearized reading' (duration: 136.474908ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T12:59:30.127368Z","caller":"traceutil/trace.go:171","msg":"trace[291667491] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"149.270849ms","start":"2026-02-03T12:59:29.97808Z","end":"2026-02-03T12:59:30.12735Z","steps":["trace[291667491] 'process raft request' (duration: 145.655199ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T12:59:30.136922Z","caller":"traceutil/trace.go:171","msg":"trace[1205089882] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"156.442607ms","start":"2026-02-03T12:59:29.980468Z","end":"2026-02-03T12:59:30.13691Z","steps":["trace[1205089882] 'process raft request' (duration: 156.408336ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T12:59:30.1372Z","caller":"traceutil/trace.go:171","msg":"trace[1678757268] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"158.723466ms","start":"2026-02-03T12:59:29.978466Z","end":"2026-02-03T12:59:30.137189Z","steps":["trace[1678757268] 'process raft request' (duration: 158.349968ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T12:59:42.204854Z","caller":"traceutil/trace.go:171","msg":"trace[2007652177] transaction","detail":"{read_only:false; response_revision:876; number_of_response:1; }","duration":"124.188457ms","start":"2026-02-03T12:59:42.080635Z","end":"2026-02-03T12:59:42.204824Z","steps":["trace[2007652177] 'process raft request' (duration: 124.022444ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T12:59:43.428346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.259638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.209\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-03T12:59:43.428581Z","caller":"traceutil/trace.go:171","msg":"trace[1108605519] range","detail":"{range_begin:/registry/masterleases/199.204.45.209; range_end:; response_count:1; response_revision:880; }","duration":"103.540844ms","start":"2026-02-03T12:59:43.325028Z","end":"2026-02-03T12:59:43.428569Z","steps":["trace[1108605519] 'range keys from in-memory index tree' (duration: 103.138706ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T12:59:59.470262Z","caller":"traceutil/trace.go:171","msg":"trace[138458870] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"179.400831ms","start":"2026-02-03T12:59:59.290837Z","end":"2026-02-03T12:59:59.470238Z","steps":["trace[138458870] 'process raft request' (duration: 179.166556ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T13:00:00.597048Z","caller":"traceutil/trace.go:171","msg":"trace[639488396] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"109.489116ms","start":"2026-02-03T13:00:00.487513Z","end":"2026-02-03T13:00:00.597002Z","steps":["trace[639488396] 'process raft request' (duration: 109.293351ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T13:00:04.57925Z","caller":"traceutil/trace.go:171","msg":"trace[1571562414] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"143.41008ms","start":"2026-02-03T13:00:04.43582Z","end":"2026-02-03T13:00:04.579231Z","steps":["trace[1571562414] 'process raft request' (duration: 143.239326ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T13:00:04.824056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.367921ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-03T13:00:04.824189Z","caller":"traceutil/trace.go:171","msg":"trace[152245699] linearizableReadLoop","detail":"{readStateIndex:988; appliedIndex:986; }","duration":"202.178052ms","start":"2026-02-03T13:00:04.622001Z","end":"2026-02-03T13:00:04.824179Z","steps":["trace[152245699] 'read index received' (duration: 43.998287ms)","trace[152245699] 'applied index is now lower than readState.Index' (duration: 158.179215ms)"],"step_count":2} {"level":"info","ts":"2026-02-03T13:00:04.824317Z","caller":"traceutil/trace.go:171","msg":"trace[1809885526] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"240.637496ms","start":"2026-02-03T13:00:04.583675Z","end":"2026-02-03T13:00:04.824312Z","steps":["trace[1809885526] 'compare' (duration: 230.192426ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T13:00:04.824436Z","caller":"traceutil/trace.go:171","msg":"trace[1975731451] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"237.105179ms","start":"2026-02-03T13:00:04.587324Z","end":"2026-02-03T13:00:04.824429Z","steps":["trace[1975731451] 'process raft request' (duration: 236.805352ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T13:00:04.824571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.57083ms","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-03T13:00:04.824591Z","caller":"traceutil/trace.go:171","msg":"trace[1813183171] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:949; }","duration":"202.626872ms","start":"2026-02-03T13:00:04.621956Z","end":"2026-02-03T13:00:04.824583Z","steps":["trace[1813183171] 'agreement among raft nodes before linearized reading' (duration: 202.54967ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T13:00:04.824677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.910324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-03T13:00:04.824689Z","caller":"traceutil/trace.go:171","msg":"trace[73972185] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:949; }","duration":"114.958345ms","start":"2026-02-03T13:00:04.709727Z","end":"2026-02-03T13:00:04.824685Z","steps":["trace[73972185] 'agreement among raft nodes before linearized reading' (duration: 114.936005ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T13:00:05.050845Z","caller":"traceutil/trace.go:171","msg":"trace[1743789148] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"221.227669ms","start":"2026-02-03T13:00:04.829598Z","end":"2026-02-03T13:00:05.050826Z","steps":["trace[1743789148] 'process raft request' (duration: 183.975521ms)","trace[1743789148] 'compare' (duration: 37.131375ms)"],"step_count":2} {"level":"info","ts":"2026-02-03T13:00:13.245148Z","caller":"traceutil/trace.go:171","msg":"trace[543555004] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"108.449223ms","start":"2026-02-03T13:00:13.13667Z","end":"2026-02-03T13:00:13.245119Z","steps":["trace[543555004] 'process raft request' (duration: 108.280379ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T13:00:16.794874Z","caller":"traceutil/trace.go:171","msg":"trace[226933177] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"137.789406ms","start":"2026-02-03T13:00:16.657064Z","end":"2026-02-03T13:00:16.794854Z","steps":["trace[226933177] 'process raft request' (duration: 137.686124ms)"],"step_count":1}