{"level":"warn","ts":"2026-02-26T04:07:37.342692Z","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-26T04:07:37.342767Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.113: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.113:2380","--initial-cluster=instance=https://199.204.45.113:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.113:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.113: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-26T04:07:37.342828Z","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-26T04:07:37.342838Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-02-26T04:07:37.342857Z","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-26T04:07:37.343458Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"]} {"level":"info","ts":"2026-02-26T04:07:37.343554Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.113: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-26T04:07:37.428194Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"84.419455ms"} {"level":"info","ts":"2026-02-26T04:07:37.475265Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a31e123290fcf0df","cluster-id":"37661d6ee45ed9e8"} {"level":"info","ts":"2026-02-26T04:07:37.475443Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=()"} {"level":"info","ts":"2026-02-26T04:07:37.47548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 0"} {"level":"info","ts":"2026-02-26T04:07:37.475496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a31e123290fcf0df [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-26T04:07:37.47557Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 1"} {"level":"info","ts":"2026-02-26T04:07:37.475631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"warn","ts":"2026-02-26T04:07:37.493389Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-26T04:07:37.50361Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-26T04:07:37.507672Z","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-26T04:07:37.51397Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a31e123290fcf0df","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-26T04:07:37.51455Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a31e123290fcf0df","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-26T04:07:37.514754Z","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-26T04:07:37.514783Z","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-26T04:07:37.514805Z","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-26T04:07:37.515111Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"info","ts":"2026-02-26T04:07:37.515325Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","added-peer-id":"a31e123290fcf0df","added-peer-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-02-26T04:07:37.518579Z","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-26T04:07:37.518763Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a31e123290fcf0df","initial-advertise-peer-urls":["https://199.204.45.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-26T04:07:37.518789Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-26T04:07:37.518879Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-02-26T04:07:37.518889Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-02-26T04:07:37.877036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df is starting a new election at term 1"} {"level":"info","ts":"2026-02-26T04:07:37.877101Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became pre-candidate at term 1"} {"level":"info","ts":"2026-02-26T04:07:37.877152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgPreVoteResp from a31e123290fcf0df at term 1"} {"level":"info","ts":"2026-02-26T04:07:37.877179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became candidate at term 2"} {"level":"info","ts":"2026-02-26T04:07:37.877256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgVoteResp from a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-02-26T04:07:37.877398Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became leader at term 2"} {"level":"info","ts":"2026-02-26T04:07:37.87748Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a31e123290fcf0df elected leader a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-02-26T04:07:37.885823Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T04:07:37.890014Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a31e123290fcf0df","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.113:2379]}","request-path":"/0/members/a31e123290fcf0df/attributes","cluster-id":"37661d6ee45ed9e8","publish-timeout":"7s"} {"level":"info","ts":"2026-02-26T04:07:37.890183Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T04:07:37.890289Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T04:07:37.892686Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T04:07:37.892854Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T04:07:37.8929Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T04:07:37.893079Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-26T04:07:37.893208Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-26T04:07:37.893365Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.113:2379"} {"level":"info","ts":"2026-02-26T04:07:37.894573Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-26T04:07:39.903003Z","caller":"traceutil/trace.go:171","msg":"trace[1760248267] linearizableReadLoop","detail":"{readStateIndex:30; appliedIndex:29; }","duration":"265.308421ms","start":"2026-02-26T04:07:39.637642Z","end":"2026-02-26T04:07:39.90295Z","steps":["trace[1760248267] 'read index received' (duration: 167.332277ms)","trace[1760248267] 'applied index is now lower than readState.Index' (duration: 97.974474ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T04:07:39.903219Z","caller":"traceutil/trace.go:171","msg":"trace[1136260995] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"265.616944ms","start":"2026-02-26T04:07:39.637586Z","end":"2026-02-26T04:07:39.903203Z","steps":["trace[1136260995] 'process raft request' (duration: 167.373747ms)","trace[1136260995] 'compare' (duration: 97.775631ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T04:07:39.903426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.740916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T04:07:39.903608Z","caller":"traceutil/trace.go:171","msg":"trace[750049829] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:26; }","duration":"265.945949ms","start":"2026-02-26T04:07:39.637624Z","end":"2026-02-26T04:07:39.90357Z","steps":["trace[750049829] 'agreement among raft nodes before linearized reading' (duration: 265.646145ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:07:39.953854Z","caller":"traceutil/trace.go:171","msg":"trace[987991192] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"315.994188ms","start":"2026-02-26T04:07:39.637828Z","end":"2026-02-26T04:07:39.953822Z","steps":["trace[987991192] 'process raft request' (duration: 315.804316ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:07:39.953968Z","caller":"traceutil/trace.go:171","msg":"trace[998756722] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"314.341208ms","start":"2026-02-26T04:07:39.639589Z","end":"2026-02-26T04:07:39.95393Z","steps":["trace[998756722] 'process raft request' (duration: 314.202486ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:07:39.954191Z","caller":"traceutil/trace.go:171","msg":"trace[2042697003] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"301.303094ms","start":"2026-02-26T04:07:39.652861Z","end":"2026-02-26T04:07:39.954164Z","steps":["trace[2042697003] 'process raft request' (duration: 300.98746ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:07:39.954331Z","caller":"traceutil/trace.go:171","msg":"trace[1227181117] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"314.596691ms","start":"2026-02-26T04:07:39.639672Z","end":"2026-02-26T04:07:39.954269Z","steps":["trace[1227181117] 'process raft request' (duration: 314.149225ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:07:39.954395Z","caller":"traceutil/trace.go:171","msg":"trace[262043443] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"286.922013ms","start":"2026-02-26T04:07:39.667424Z","end":"2026-02-26T04:07:39.954346Z","steps":["trace[262043443] 'process raft request' (duration: 286.473617ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:07:39.9548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.397388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-26T04:07:39.954834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:07:39.639654Z","time spent":"314.735813ms","remote":"127.0.0.1:44268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":950,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T04:07:39.954836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:07:39.637819Z","time spent":"316.09372ms","remote":"127.0.0.1:44168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":713,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T04:07:39.954894Z","caller":"traceutil/trace.go:171","msg":"trace[1040690878] range","detail":"{range_begin:/registry/resourcequotas/kube-node-lease/; range_end:/registry/resourcequotas/kube-node-lease0; response_count:0; response_revision:32; }","duration":"315.237109ms","start":"2026-02-26T04:07:39.639636Z","end":"2026-02-26T04:07:39.954873Z","steps":["trace[1040690878] 'agreement among raft nodes before linearized reading' (duration: 314.310627ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:07:39.954896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:07:39.63958Z","time spent":"314.484029ms","remote":"127.0.0.1:44268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":959,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T04:07:39.954948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:07:39.639621Z","time spent":"315.30914ms","remote":"127.0.0.1:43782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" "} {"level":"warn","ts":"2026-02-26T04:07:39.955019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:07:39.652842Z","time spent":"301.448235ms","remote":"127.0.0.1:43798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":357,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T04:07:39.954623Z","caller":"traceutil/trace.go:171","msg":"trace[934594256] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"315.134118ms","start":"2026-02-26T04:07:39.639464Z","end":"2026-02-26T04:07:39.954598Z","steps":["trace[934594256] 'process raft request' (duration: 314.290177ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:07:39.955357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:07:39.63945Z","time spent":"315.866867ms","remote":"127.0.0.1:44268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":983,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T04:07:40.348134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.605906ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-26T04:07:40.348404Z","caller":"traceutil/trace.go:171","msg":"trace[595817217] linearizableReadLoop","detail":"{readStateIndex:38; appliedIndex:36; }","duration":"390.824805ms","start":"2026-02-26T04:07:39.957557Z","end":"2026-02-26T04:07:40.348381Z","steps":["trace[595817217] 'read index received' (duration: 238.785843ms)","trace[595817217] 'applied index is now lower than readState.Index' (duration: 152.037822ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T04:07:40.348647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.990227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T04:07:40.348588Z","caller":"traceutil/trace.go:171","msg":"trace[2110025450] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"391.374361ms","start":"2026-02-26T04:07:39.957114Z","end":"2026-02-26T04:07:40.348489Z","steps":["trace[2110025450] 'process raft request' (duration: 391.137988ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:07:40.348781Z","caller":"traceutil/trace.go:171","msg":"trace[1849906525] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"389.859393ms","start":"2026-02-26T04:07:39.958903Z","end":"2026-02-26T04:07:40.348762Z","steps":["trace[1849906525] 'process raft request' (duration: 389.425177ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:07:40.348728Z","caller":"traceutil/trace.go:171","msg":"trace[1518179027] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:0; response_revision:35; }","duration":"391.188279ms","start":"2026-02-26T04:07:39.957513Z","end":"2026-02-26T04:07:40.348702Z","steps":["trace[1518179027] 'agreement among raft nodes before linearized reading' (duration: 390.942476ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:07:40.348778Z","caller":"traceutil/trace.go:171","msg":"trace[1330887413] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"441.961208ms","start":"2026-02-26T04:07:39.906777Z","end":"2026-02-26T04:07:40.348739Z","steps":["trace[1330887413] 'process raft request' (duration: 289.40988ms)","trace[1330887413] 'compare' (duration: 151.436114ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T04:07:40.348881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:07:39.958884Z","time spent":"389.950143ms","remote":"127.0.0.1:44168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":711,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T04:07:40.348904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:07:39.957087Z","time spent":"391.692306ms","remote":"127.0.0.1:43804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":350,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T04:07:40.348937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:07:39.957495Z","time spent":"391.407391ms","remote":"127.0.0.1:43860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":27,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-26T04:07:40.349023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:07:39.906754Z","time spent":"442.184131ms","remote":"127.0.0.1:43798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3004,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T04:07:40.633153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.544919ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-26T04:07:40.633304Z","caller":"traceutil/trace.go:171","msg":"trace[548504261] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"233.318063ms","start":"2026-02-26T04:07:40.399947Z","end":"2026-02-26T04:07:40.633265Z","steps":["trace[548504261] 'process raft request' (duration: 72.592523ms)","trace[548504261] 'compare' (duration: 160.398466ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T04:07:40.633432Z","caller":"traceutil/trace.go:171","msg":"trace[1139766352] linearizableReadLoop","detail":"{readStateIndex:41; appliedIndex:40; }","duration":"232.537494ms","start":"2026-02-26T04:07:40.400838Z","end":"2026-02-26T04:07:40.633376Z","steps":["trace[1139766352] 'read index received' (duration: 71.723112ms)","trace[1139766352] 'applied index is now lower than readState.Index' (duration: 160.813222ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T04:07:40.633347Z","caller":"traceutil/trace.go:171","msg":"trace[1039584227] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"232.095788ms","start":"2026-02-26T04:07:40.401232Z","end":"2026-02-26T04:07:40.633328Z","steps":["trace[1039584227] 'process raft request' (duration: 232.036967ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:07:40.633935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.700321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-26T04:07:40.633946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.479349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-26T04:07:40.633936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.07159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T04:07:40.633986Z","caller":"traceutil/trace.go:171","msg":"trace[1749623049] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:38; }","duration":"133.822172ms","start":"2026-02-26T04:07:40.500151Z","end":"2026-02-26T04:07:40.633973Z","steps":["trace[1749623049] 'agreement among raft nodes before linearized reading' (duration: 133.63463ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:07:40.633995Z","caller":"traceutil/trace.go:171","msg":"trace[1432406623] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:38; }","duration":"133.573539ms","start":"2026-02-26T04:07:40.500408Z","end":"2026-02-26T04:07:40.633982Z","steps":["trace[1432406623] 'agreement among raft nodes before linearized reading' (duration: 133.493278ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:07:40.634035Z","caller":"traceutil/trace.go:171","msg":"trace[205659658] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:0; response_revision:38; }","duration":"233.232583ms","start":"2026-02-26T04:07:40.400775Z","end":"2026-02-26T04:07:40.634008Z","steps":["trace[205659658] 'agreement among raft nodes before linearized reading' (duration: 232.989669ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:07:40.871591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.131762ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-26T04:07:40.87176Z","caller":"traceutil/trace.go:171","msg":"trace[1376946623] linearizableReadLoop","detail":"{readStateIndex:49; appliedIndex:47; }","duration":"140.892611ms","start":"2026-02-26T04:07:40.73085Z","end":"2026-02-26T04:07:40.871743Z","steps":["trace[1376946623] 'read index received' (duration: 23.410924ms)","trace[1376946623] 'applied index is now lower than readState.Index' (duration: 117.480677ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T04:07:40.871929Z","caller":"traceutil/trace.go:171","msg":"trace[224268772] transaction","detail":"{read_only:false; response_revision:45; number_of_response:1; }","duration":"184.909074ms","start":"2026-02-26T04:07:40.686998Z","end":"2026-02-26T04:07:40.871907Z","steps":["trace[224268772] 'process raft request' (duration: 184.675891ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:07:40.871929Z","caller":"traceutil/trace.go:171","msg":"trace[1860808110] transaction","detail":"{read_only:false; response_revision:44; number_of_response:1; }","duration":"185.296739ms","start":"2026-02-26T04:07:40.686493Z","end":"2026-02-26T04:07:40.87179Z","steps":["trace[1860808110] 'process raft request' (duration: 67.850983ms)","trace[1860808110] 'compare' (duration: 116.93206ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T04:07:40.872038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.182784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T04:07:40.872094Z","caller":"traceutil/trace.go:171","msg":"trace[695700816] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:0; response_revision:45; }","duration":"141.287006ms","start":"2026-02-26T04:07:40.730794Z","end":"2026-02-26T04:07:40.872081Z","steps":["trace[695700816] 'agreement among raft nodes before linearized reading' (duration: 141.152924ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:07:40.872329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.660225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/system-node-high\" ","response":"range_response_count:1 size:1132"} {"level":"warn","ts":"2026-02-26T04:07:40.872327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.156863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T04:07:40.872443Z","caller":"traceutil/trace.go:171","msg":"trace[1363841754] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:45; }","duration":"133.323325ms","start":"2026-02-26T04:07:40.739093Z","end":"2026-02-26T04:07:40.872416Z","steps":["trace[1363841754] 'agreement among raft nodes before linearized reading' (duration: 133.076342ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:07:40.872473Z","caller":"traceutil/trace.go:171","msg":"trace[1416841348] range","detail":"{range_begin:/registry/flowschemas/system-node-high; range_end:; response_count:1; response_revision:45; }","duration":"139.778507ms","start":"2026-02-26T04:07:40.732614Z","end":"2026-02-26T04:07:40.872393Z","steps":["trace[1416841348] 'agreement among raft nodes before linearized reading' (duration: 139.515494ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:07:41.047803Z","caller":"traceutil/trace.go:171","msg":"trace[685706990] transaction","detail":"{read_only:false; response_revision:47; number_of_response:1; }","duration":"170.575484ms","start":"2026-02-26T04:07:40.877198Z","end":"2026-02-26T04:07:41.047774Z","steps":["trace[685706990] 'process raft request' (duration: 109.75371ms)","trace[685706990] 'compare' (duration: 60.637552ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T04:07:41.408596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.59758ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-02-26T04:07:41.408827Z","caller":"traceutil/trace.go:171","msg":"trace[574085105] linearizableReadLoop","detail":"{readStateIndex:56; appliedIndex:53; }","duration":"270.078811ms","start":"2026-02-26T04:07:41.13873Z","end":"2026-02-26T04:07:41.408809Z","steps":["trace[574085105] 'read index received' (duration: 45.213338ms)","trace[574085105] 'applied index is now lower than readState.Index' (duration: 224.864353ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T04:07:41.408958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.223662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T04:07:41.408995Z","caller":"traceutil/trace.go:171","msg":"trace[1761626606] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:52; }","duration":"270.310554ms","start":"2026-02-26T04:07:41.138672Z","end":"2026-02-26T04:07:41.408982Z","steps":["trace[1761626606] 'agreement among raft nodes before linearized reading' (duration: 270.210333ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:07:41.409295Z","caller":"traceutil/trace.go:171","msg":"trace[1268705730] transaction","detail":"{read_only:false; response_revision:50; number_of_response:1; }","duration":"357.299375ms","start":"2026-02-26T04:07:41.051966Z","end":"2026-02-26T04:07:41.409265Z","steps":["trace[1268705730] 'process raft request' (duration: 131.792444ms)","trace[1268705730] 'compare' (duration: 224.426078ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T04:07:41.409454Z","caller":"traceutil/trace.go:171","msg":"trace[1168195944] transaction","detail":"{read_only:false; response_revision:51; number_of_response:1; }","duration":"356.09772ms","start":"2026-02-26T04:07:41.053331Z","end":"2026-02-26T04:07:41.409429Z","steps":["trace[1168195944] 'process raft request' (duration: 355.381501ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:07:41.409324Z","caller":"traceutil/trace.go:171","msg":"trace[1165449533] transaction","detail":"{read_only:false; response_revision:52; number_of_response:1; }","duration":"321.706569ms","start":"2026-02-26T04:07:41.087579Z","end":"2026-02-26T04:07:41.409285Z","steps":["trace[1165449533] 'process raft request' (duration: 321.190692ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:07:41.409608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:07:41.053323Z","time spent":"356.237052ms","remote":"127.0.0.1:44046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T04:07:41.409516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:07:41.051943Z","time spent":"357.462167ms","remote":"127.0.0.1:44152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1059,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T04:07:41.409725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:07:41.087558Z","time spent":"322.098063ms","remote":"127.0.0.1:44152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":671,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T04:07:41.726079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.31969ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-02-26T04:07:41.726313Z","caller":"traceutil/trace.go:171","msg":"trace[787786251] linearizableReadLoop","detail":"{readStateIndex:60; appliedIndex:57; }","duration":"220.110703ms","start":"2026-02-26T04:07:41.506182Z","end":"2026-02-26T04:07:41.726292Z","steps":["trace[787786251] 'read index received' (duration: 13.479199ms)","trace[787786251] 'applied index is now lower than readState.Index' (duration: 206.629954ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T04:07:41.726299Z","caller":"traceutil/trace.go:171","msg":"trace[2126711666] transaction","detail":"{read_only:false; response_revision:54; number_of_response:1; }","duration":"311.195655ms","start":"2026-02-26T04:07:41.415073Z","end":"2026-02-26T04:07:41.726268Z","steps":["trace[2126711666] 'process raft request' (duration: 104.572922ms)","trace[2126711666] 'compare' (duration: 206.150668ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T04:07:41.726417Z","caller":"traceutil/trace.go:171","msg":"trace[1039855293] transaction","detail":"{read_only:false; response_revision:55; number_of_response:1; }","duration":"310.821701ms","start":"2026-02-26T04:07:41.415569Z","end":"2026-02-26T04:07:41.726391Z","steps":["trace[1039855293] 'process raft request' (duration: 310.621758ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:07:41.726541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:07:41.415562Z","time spent":"310.916402ms","remote":"127.0.0.1:44046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":634,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T04:07:41.726591Z","caller":"traceutil/trace.go:171","msg":"trace[895200214] transaction","detail":"{read_only:false; response_revision:56; number_of_response:1; }","duration":"283.873182ms","start":"2026-02-26T04:07:41.442705Z","end":"2026-02-26T04:07:41.726578Z","steps":["trace[895200214] 'process raft request' (duration: 283.545728ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:07:41.726572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:07:41.415064Z","time spent":"311.380378ms","remote":"127.0.0.1:44152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1216,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T04:07:41.726868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.860205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T04:07:41.726944Z","caller":"traceutil/trace.go:171","msg":"trace[394190417] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:56; }","duration":"119.965586ms","start":"2026-02-26T04:07:41.606959Z","end":"2026-02-26T04:07:41.726925Z","steps":["trace[394190417] 'agreement among raft nodes before linearized reading' (duration: 119.633522ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:07:41.727425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.243108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T04:07:41.72748Z","caller":"traceutil/trace.go:171","msg":"trace[1276726087] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:56; }","duration":"221.335368ms","start":"2026-02-26T04:07:41.506132Z","end":"2026-02-26T04:07:41.727468Z","steps":["trace[1276726087] 'agreement among raft nodes before linearized reading' (duration: 220.582379ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:07:41.992918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.448406ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-02-26T04:07:41.99323Z","caller":"traceutil/trace.go:171","msg":"trace[2051248622] transaction","detail":"{read_only:false; response_revision:60; number_of_response:1; }","duration":"205.414549ms","start":"2026-02-26T04:07:41.787768Z","end":"2026-02-26T04:07:41.993183Z","steps":["trace[2051248622] 'process raft request' (duration: 205.318608ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:07:41.99323Z","caller":"traceutil/trace.go:171","msg":"trace[1525509645] linearizableReadLoop","detail":"{readStateIndex:63; appliedIndex:61; }","duration":"251.281174ms","start":"2026-02-26T04:07:41.741917Z","end":"2026-02-26T04:07:41.993198Z","steps":["trace[1525509645] 'read index received' (duration: 43.432895ms)","trace[1525509645] 'applied index is now lower than readState.Index' (duration: 207.845559ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T04:07:41.99326Z","caller":"traceutil/trace.go:171","msg":"trace[1734917459] transaction","detail":"{read_only:false; response_revision:59; number_of_response:1; }","duration":"260.51633ms","start":"2026-02-26T04:07:41.732708Z","end":"2026-02-26T04:07:41.993224Z","steps":["trace[1734917459] 'process raft request' (duration: 260.312408ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:07:41.993593Z","caller":"traceutil/trace.go:171","msg":"trace[1181748406] transaction","detail":"{read_only:false; response_revision:58; number_of_response:1; }","duration":"262.473424ms","start":"2026-02-26T04:07:41.731085Z","end":"2026-02-26T04:07:41.993558Z","steps":["trace[1181748406] 'process raft request' (duration: 100.283959ms)","trace[1181748406] 'compare' (duration: 161.218103ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T04:07:41.993705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.711649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T04:07:41.993776Z","caller":"traceutil/trace.go:171","msg":"trace[1734302154] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:60; }","duration":"251.859891ms","start":"2026-02-26T04:07:41.741901Z","end":"2026-02-26T04:07:41.993761Z","steps":["trace[1734302154] 'agreement among raft nodes before linearized reading' (duration: 251.502116ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:07:42.240999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.578818ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-02-26T04:07:42.241252Z","caller":"traceutil/trace.go:171","msg":"trace[1967142645] transaction","detail":"{read_only:false; response_revision:62; number_of_response:1; }","duration":"242.423419ms","start":"2026-02-26T04:07:41.998791Z","end":"2026-02-26T04:07:42.241215Z","steps":["trace[1967142645] 'process raft request' (duration: 130.538577ms)","trace[1967142645] 'compare' (duration: 111.444117ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T04:07:42.241367Z","caller":"traceutil/trace.go:171","msg":"trace[90354592] linearizableReadLoop","detail":"{readStateIndex:68; appliedIndex:65; }","duration":"188.771006ms","start":"2026-02-26T04:07:42.052492Z","end":"2026-02-26T04:07:42.241263Z","steps":["trace[90354592] 'read index received' (duration: 76.785152ms)","trace[90354592] 'applied index is now lower than readState.Index' (duration: 111.984874ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T04:07:42.241438Z","caller":"traceutil/trace.go:171","msg":"trace[2020774908] transaction","detail":"{read_only:false; response_revision:64; number_of_response:1; }","duration":"214.55079ms","start":"2026-02-26T04:07:42.026877Z","end":"2026-02-26T04:07:42.241428Z","steps":["trace[2020774908] 'process raft request' (duration: 214.342067ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:07:42.24152Z","caller":"traceutil/trace.go:171","msg":"trace[1899300927] transaction","detail":"{read_only:false; response_revision:63; number_of_response:1; }","duration":"241.898772ms","start":"2026-02-26T04:07:41.999614Z","end":"2026-02-26T04:07:42.241512Z","steps":["trace[1899300927] 'process raft request' (duration: 241.551937ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:07:42.241582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.094621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T04:07:42.241655Z","caller":"traceutil/trace.go:171","msg":"trace[2132133400] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:64; }","duration":"189.195271ms","start":"2026-02-26T04:07:42.052445Z","end":"2026-02-26T04:07:42.241641Z","steps":["trace[2132133400] 'agreement among raft nodes before linearized reading' (duration: 188.987419ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:07:51.330317Z","caller":"traceutil/trace.go:171","msg":"trace[1866306695] linearizableReadLoop","detail":"{readStateIndex:366; appliedIndex:365; }","duration":"397.221779ms","start":"2026-02-26T04:07:50.933071Z","end":"2026-02-26T04:07:51.330293Z","steps":["trace[1866306695] 'read index received' (duration: 396.945765ms)","trace[1866306695] 'applied index is now lower than readState.Index' (duration: 275.134µs)"],"step_count":2} {"level":"warn","ts":"2026-02-26T04:07:51.330664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.575943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"} {"level":"warn","ts":"2026-02-26T04:07:51.330668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.346947ms","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-26T04:07:51.33071Z","caller":"traceutil/trace.go:171","msg":"trace[219698808] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:354; }","duration":"397.655655ms","start":"2026-02-26T04:07:50.933041Z","end":"2026-02-26T04:07:51.330697Z","steps":["trace[219698808] 'agreement among raft nodes before linearized reading' (duration: 397.577354ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:07:51.330721Z","caller":"traceutil/trace.go:171","msg":"trace[572059266] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:354; }","duration":"274.437618ms","start":"2026-02-26T04:07:51.056269Z","end":"2026-02-26T04:07:51.330707Z","steps":["trace[572059266] 'agreement among raft nodes before linearized reading' (duration: 274.321897ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:07:51.330691Z","caller":"traceutil/trace.go:171","msg":"trace[738088387] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"447.508412ms","start":"2026-02-26T04:07:50.883147Z","end":"2026-02-26T04:07:51.330655Z","steps":["trace[738088387] 'process raft request' (duration: 446.954205ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:07:51.330745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:07:50.933027Z","time spent":"397.710255ms","remote":"127.0.0.1:43866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4349,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"warn","ts":"2026-02-26T04:07:51.330872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:07:50.883125Z","time spent":"447.654205ms","remote":"127.0.0.1:43938","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-26T04:07:56.755374Z","caller":"traceutil/trace.go:171","msg":"trace[389112732] linearizableReadLoop","detail":"{readStateIndex:386; appliedIndex:385; }","duration":"182.085851ms","start":"2026-02-26T04:07:56.573269Z","end":"2026-02-26T04:07:56.755355Z","steps":["trace[389112732] 'read index received' (duration: 181.913599ms)","trace[389112732] 'applied index is now lower than readState.Index' (duration: 171.632µs)"],"step_count":2} {"level":"warn","ts":"2026-02-26T04:07:56.755498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.222852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T04:07:56.755556Z","caller":"traceutil/trace.go:171","msg":"trace[2028551902] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:373; }","duration":"182.328804ms","start":"2026-02-26T04:07:56.573218Z","end":"2026-02-26T04:07:56.755547Z","steps":["trace[2028551902] 'agreement among raft nodes before linearized reading' (duration: 182.243933ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:07:56.755479Z","caller":"traceutil/trace.go:171","msg":"trace[309782091] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"555.110551ms","start":"2026-02-26T04:07:56.200322Z","end":"2026-02-26T04:07:56.755433Z","steps":["trace[309782091] 'process raft request' (duration: 554.908998ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:07:56.755726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:07:56.200307Z","time spent":"555.307544ms","remote":"127.0.0.1:43938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T04:07:56.755767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.79249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4056"} {"level":"info","ts":"2026-02-26T04:07:56.755845Z","caller":"traceutil/trace.go:171","msg":"trace[330542040] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:373; }","duration":"134.915831ms","start":"2026-02-26T04:07:56.620911Z","end":"2026-02-26T04:07:56.755827Z","steps":["trace[330542040] 'agreement among raft nodes before linearized reading' (duration: 134.727448ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:07:57.786204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.955834ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T04:07:57.786314Z","caller":"traceutil/trace.go:171","msg":"trace[738337829] linearizableReadLoop","detail":"{readStateIndex:387; appliedIndex:386; }","duration":"423.01759ms","start":"2026-02-26T04:07:57.363281Z","end":"2026-02-26T04:07:57.786298Z","steps":["trace[738337829] 'read index received' (duration: 254.910984ms)","trace[738337829] 'applied index is now lower than readState.Index' (duration: 168.105406ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T04:07:57.786452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.096501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-26T04:07:57.786487Z","caller":"traceutil/trace.go:171","msg":"trace[63039787] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:374; }","duration":"423.175161ms","start":"2026-02-26T04:07:57.363302Z","end":"2026-02-26T04:07:57.786477Z","steps":["trace[63039787] 'agreement among raft nodes before linearized reading' (duration: 423.10885ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:07:57.786523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:07:57.363271Z","time spent":"423.244003ms","remote":"127.0.0.1:43938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-26T04:07:57.786499Z","caller":"traceutil/trace.go:171","msg":"trace[1072052467] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"1.016394836s","start":"2026-02-26T04:07:56.769932Z","end":"2026-02-26T04:07:57.786327Z","steps":["trace[1072052467] 'process raft request' (duration: 848.24674ms)","trace[1072052467] 'compare' (duration: 167.825872ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T04:07:57.786626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.176643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-26T04:07:57.78666Z","caller":"traceutil/trace.go:171","msg":"trace[500844425] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:374; }","duration":"214.266133ms","start":"2026-02-26T04:07:57.572386Z","end":"2026-02-26T04:07:57.786652Z","steps":["trace[500844425] 'agreement among raft nodes before linearized reading' (duration: 214.185632ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:07:57.786709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:07:56.769903Z","time spent":"1.01674091s","remote":"127.0.0.1:44172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T04:07:57.787047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.731859ms","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-26T04:07:57.787245Z","caller":"traceutil/trace.go:171","msg":"trace[2118259365] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:374; }","duration":"423.90833ms","start":"2026-02-26T04:07:57.363232Z","end":"2026-02-26T04:07:57.787141Z","steps":["trace[2118259365] 'agreement among raft nodes before linearized reading' (duration: 423.319283ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:07:57.787624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:07:57.363213Z","time spent":"424.130613ms","remote":"127.0.0.1:43938","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":"info","ts":"2026-02-26T04:08:03.992472Z","caller":"traceutil/trace.go:171","msg":"trace[1122185378] linearizableReadLoop","detail":"{readStateIndex:437; appliedIndex:435; }","duration":"110.698352ms","start":"2026-02-26T04:08:03.881746Z","end":"2026-02-26T04:08:03.992445Z","steps":["trace[1122185378] 'read index received' (duration: 35.143409ms)","trace[1122185378] 'applied index is now lower than readState.Index' (duration: 75.553863ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T04:08:03.992536Z","caller":"traceutil/trace.go:171","msg":"trace[14233855] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"130.960368ms","start":"2026-02-26T04:08:03.861543Z","end":"2026-02-26T04:08:03.992503Z","steps":["trace[14233855] 'process raft request' (duration: 55.195064ms)","trace[14233855] 'compare' (duration: 75.552702ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T04:08:03.992604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.838273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T04:08:03.992641Z","caller":"traceutil/trace.go:171","msg":"trace[1530079934] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:421; }","duration":"110.936654ms","start":"2026-02-26T04:08:03.881693Z","end":"2026-02-26T04:08:03.99263Z","steps":["trace[1530079934] 'agreement among raft nodes before linearized reading' (duration: 110.847503ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:08:03.992944Z","caller":"traceutil/trace.go:171","msg":"trace[1449844279] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"131.188381ms","start":"2026-02-26T04:08:03.86172Z","end":"2026-02-26T04:08:03.992908Z","steps":["trace[1449844279] 'process raft request' (duration: 130.684075ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:08:10.68401Z","caller":"traceutil/trace.go:171","msg":"trace[1478243743] linearizableReadLoop","detail":"{readStateIndex:486; appliedIndex:485; }","duration":"109.872321ms","start":"2026-02-26T04:08:10.574116Z","end":"2026-02-26T04:08:10.683988Z","steps":["trace[1478243743] 'read index received' (duration: 109.629128ms)","trace[1478243743] 'applied index is now lower than readState.Index' (duration: 242.183µs)"],"step_count":2} {"level":"warn","ts":"2026-02-26T04:08:10.684214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.083604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T04:08:10.684247Z","caller":"traceutil/trace.go:171","msg":"trace[1280851535] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:469; }","duration":"110.160885ms","start":"2026-02-26T04:08:10.574075Z","end":"2026-02-26T04:08:10.684236Z","steps":["trace[1280851535] 'agreement among raft nodes before linearized reading' (duration: 110.066874ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:08:10.684559Z","caller":"traceutil/trace.go:171","msg":"trace[1314517093] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"369.948664ms","start":"2026-02-26T04:08:10.3146Z","end":"2026-02-26T04:08:10.684548Z","steps":["trace[1314517093] 'process raft request' (duration: 369.264656ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:08:10.68468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:08:10.314577Z","time spent":"370.024455ms","remote":"127.0.0.1:43938","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-26T04:08:11.212016Z","caller":"traceutil/trace.go:171","msg":"trace[2135484197] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"388.997054ms","start":"2026-02-26T04:08:10.822995Z","end":"2026-02-26T04:08:11.211992Z","steps":["trace[2135484197] 'process raft request' (duration: 388.851652ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:08:11.212167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:08:10.822983Z","time spent":"389.112155ms","remote":"127.0.0.1:43938","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-26T04:08:11.406193Z","caller":"traceutil/trace.go:171","msg":"trace[1595208719] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"126.106517ms","start":"2026-02-26T04:08:11.280061Z","end":"2026-02-26T04:08:11.406167Z","steps":["trace[1595208719] 'process raft request' (duration: 125.939715ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:08:12.119064Z","caller":"traceutil/trace.go:171","msg":"trace[1666098874] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"221.617083ms","start":"2026-02-26T04:08:11.897414Z","end":"2026-02-26T04:08:12.119031Z","steps":["trace[1666098874] 'process raft request' (duration: 221.456031ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:08:18.390043Z","caller":"traceutil/trace.go:171","msg":"trace[1343077043] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"381.347559ms","start":"2026-02-26T04:08:18.008664Z","end":"2026-02-26T04:08:18.390011Z","steps":["trace[1343077043] 'process raft request' (duration: 381.124556ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:08:18.390219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:08:18.008629Z","time spent":"381.505231ms","remote":"127.0.0.1:43866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T04:08:19.168032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.023676ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-26T04:08:19.16814Z","caller":"traceutil/trace.go:171","msg":"trace[1212577542] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:528; }","duration":"1.014874241s","start":"2026-02-26T04:08:18.153247Z","end":"2026-02-26T04:08:19.168121Z","steps":["trace[1212577542] 'read index received' (duration: 236.530756ms)","trace[1212577542] 'applied index is now lower than readState.Index' (duration: 778.341925ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T04:08:19.168358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.015090134s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-26T04:08:19.168429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.324086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T04:08:19.168479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.012531522s","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-26T04:08:19.168484Z","caller":"traceutil/trace.go:171","msg":"trace[65812508] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:511; }","duration":"1.015219465s","start":"2026-02-26T04:08:18.153204Z","end":"2026-02-26T04:08:19.168423Z","steps":["trace[65812508] 'agreement among raft nodes before linearized reading' (duration: 1.015046833s)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:08:19.168538Z","caller":"traceutil/trace.go:171","msg":"trace[965393374] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:511; }","duration":"1.012612423s","start":"2026-02-26T04:08:18.155904Z","end":"2026-02-26T04:08:19.168517Z","steps":["trace[965393374] 'agreement among raft nodes before linearized reading' (duration: 1.012471652s)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:08:19.168536Z","caller":"traceutil/trace.go:171","msg":"trace[1520353264] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:511; }","duration":"597.437917ms","start":"2026-02-26T04:08:18.571069Z","end":"2026-02-26T04:08:19.168507Z","steps":["trace[1520353264] 'agreement among raft nodes before linearized reading' (duration: 597.269495ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:08:19.168546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:08:18.153184Z","time spent":"1.015345796s","remote":"127.0.0.1:43938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-26T04:08:19.168584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:08:18.155896Z","time spent":"1.012679725s","remote":"127.0.0.1:43938","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-26T04:08:19.16859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:08:18.571011Z","time spent":"597.570559ms","remote":"127.0.0.1:43708","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-26T04:08:19.168783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.015472248s","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-26T04:08:19.168853Z","caller":"traceutil/trace.go:171","msg":"trace[1076578303] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:511; }","duration":"1.015538159s","start":"2026-02-26T04:08:18.153288Z","end":"2026-02-26T04:08:19.168826Z","steps":["trace[1076578303] 'agreement among raft nodes before linearized reading' (duration: 1.015035663s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:08:19.168941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:08:18.153148Z","time spent":"1.015780602s","remote":"127.0.0.1:43938","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":"warn","ts":"2026-02-26T04:08:21.578051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.314527675s","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-26T04:08:21.578103Z","caller":"traceutil/trace.go:171","msg":"trace[1442956886] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:514; }","duration":"2.314615977s","start":"2026-02-26T04:08:19.263476Z","end":"2026-02-26T04:08:21.578092Z","steps":["trace[1442956886] 'range keys from in-memory index tree' (duration: 2.314367704s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:08:21.578123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:08:19.263457Z","time spent":"2.314661577s","remote":"127.0.0.1:43938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-26T04:08:21.578251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.004871143s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T04:08:21.578309Z","caller":"traceutil/trace.go:171","msg":"trace[430743324] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:514; }","duration":"2.004911503s","start":"2026-02-26T04:08:19.573368Z","end":"2026-02-26T04:08:21.578279Z","steps":["trace[430743324] 'range keys from in-memory index tree' (duration: 2.004743911s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:08:21.578376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:08:19.573314Z","time spent":"2.005054415s","remote":"127.0.0.1:43708","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-26T04:08:21.698704Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356763666119985290,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-26T04:08:21.780314Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.0845351s","expected-duration":"1s"} {"level":"info","ts":"2026-02-26T04:08:21.780803Z","caller":"traceutil/trace.go:171","msg":"trace[467672876] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"1.085058656s","start":"2026-02-26T04:08:20.695678Z","end":"2026-02-26T04:08:21.780736Z","steps":["trace[467672876] 'process raft request' (duration: 1.084873954s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:08:21.781012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:08:20.695658Z","time spent":"1.085239278s","remote":"127.0.0.1:43938","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-26T04:08:21.784605Z","caller":"traceutil/trace.go:171","msg":"trace[1248519606] linearizableReadLoop","detail":"{readStateIndex:535; appliedIndex:533; }","duration":"586.256487ms","start":"2026-02-26T04:08:21.198319Z","end":"2026-02-26T04:08:21.784575Z","steps":["trace[1248519606] 'read index received' (duration: 582.233429ms)","trace[1248519606] 'applied index is now lower than readState.Index' (duration: 4.021978ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T04:08:21.784706Z","caller":"traceutil/trace.go:171","msg":"trace[2134436159] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"203.509733ms","start":"2026-02-26T04:08:21.581175Z","end":"2026-02-26T04:08:21.784685Z","steps":["trace[2134436159] 'process raft request' (duration: 203.28155ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:08:21.784815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.672064ms","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-26T04:08:21.784872Z","caller":"traceutil/trace.go:171","msg":"trace[679723483] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:516; }","duration":"562.758585ms","start":"2026-02-26T04:08:21.222099Z","end":"2026-02-26T04:08:21.784858Z","steps":["trace[679723483] 'agreement among raft nodes before linearized reading' (duration: 562.661624ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:08:21.784851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.281516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T04:08:21.784914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:08:21.222089Z","time spent":"562.817095ms","remote":"127.0.0.1:43938","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-26T04:08:21.784937Z","caller":"traceutil/trace.go:171","msg":"trace[1693712076] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:516; }","duration":"211.401427ms","start":"2026-02-26T04:08:21.573513Z","end":"2026-02-26T04:08:21.784915Z","steps":["trace[1693712076] 'agreement among raft nodes before linearized reading' (duration: 211.227525ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:08:21.784884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.295378ms","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-26T04:08:21.785348Z","caller":"traceutil/trace.go:171","msg":"trace[1857627002] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:516; }","duration":"586.905894ms","start":"2026-02-26T04:08:21.198429Z","end":"2026-02-26T04:08:21.785335Z","steps":["trace[1857627002] 'agreement among raft nodes before linearized reading' (duration: 586.309447ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:08:21.785494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:08:21.198423Z","time spent":"587.051666ms","remote":"127.0.0.1:43938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-26T04:08:21.785363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.046647ms","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-26T04:08:21.785702Z","caller":"traceutil/trace.go:171","msg":"trace[1358424553] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:516; }","duration":"587.34088ms","start":"2026-02-26T04:08:21.19827Z","end":"2026-02-26T04:08:21.785611Z","steps":["trace[1358424553] 'agreement among raft nodes before linearized reading' (duration: 587.032916ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:08:21.785768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:08:21.198249Z","time spent":"587.495661ms","remote":"127.0.0.1:43938","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-26T04:08:23.582328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.153731ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-26T04:08:23.58251Z","caller":"traceutil/trace.go:171","msg":"trace[1229546579] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"433.410024ms","start":"2026-02-26T04:08:23.149071Z","end":"2026-02-26T04:08:23.582481Z","steps":["trace[1229546579] 'process raft request' (duration: 332.981021ms)","trace[1229546579] 'compare' (duration: 99.813986ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T04:08:23.582591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:08:23.149059Z","time spent":"433.504795ms","remote":"127.0.0.1:44268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":950,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T04:08:23.592861Z","caller":"traceutil/trace.go:171","msg":"trace[624316777] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"267.942441ms","start":"2026-02-26T04:08:23.324897Z","end":"2026-02-26T04:08:23.592839Z","steps":["trace[624316777] 'process raft request' (duration: 267.917001ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:08:23.592969Z","caller":"traceutil/trace.go:171","msg":"trace[1799012513] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"443.316962ms","start":"2026-02-26T04:08:23.149622Z","end":"2026-02-26T04:08:23.592939Z","steps":["trace[1799012513] 'process raft request' (duration: 443.14354ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:08:23.592989Z","caller":"traceutil/trace.go:171","msg":"trace[1952803115] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"443.532706ms","start":"2026-02-26T04:08:23.149424Z","end":"2026-02-26T04:08:23.592956Z","steps":["trace[1952803115] 'process raft request' (duration: 443.284813ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:08:23.593118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:08:23.149405Z","time spent":"443.647337ms","remote":"127.0.0.1:44268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":932,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T04:08:23.593173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:08:23.149611Z","time spent":"443.425494ms","remote":"127.0.0.1:43742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T04:08:27.448488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.829936ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T04:08:27.448718Z","caller":"traceutil/trace.go:171","msg":"trace[761789978] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"300.190207ms","start":"2026-02-26T04:08:27.148492Z","end":"2026-02-26T04:08:27.448682Z","steps":["trace[761789978] 'process raft request' (duration: 111.079007ms)","trace[761789978] 'compare' (duration: 188.690404ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T04:08:27.448853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:08:27.148479Z","time spent":"300.339138ms","remote":"127.0.0.1:43938","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-26T04:08:27.475265Z","caller":"traceutil/trace.go:171","msg":"trace[1113608338] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"151.449739ms","start":"2026-02-26T04:08:27.323778Z","end":"2026-02-26T04:08:27.475228Z","steps":["trace[1113608338] 'read index received' (duration: 151.113185ms)","trace[1113608338] 'applied index is now lower than readState.Index' (duration: 335.144µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T04:08:27.475329Z","caller":"traceutil/trace.go:171","msg":"trace[686848388] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"322.217369ms","start":"2026-02-26T04:08:27.153065Z","end":"2026-02-26T04:08:27.475282Z","steps":["trace[686848388] 'process raft request' (duration: 321.963866ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:08:27.475546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:08:27.153029Z","time spent":"322.392742ms","remote":"127.0.0.1:43742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T04:08:27.475657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.797563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-02-26T04:08:27.475762Z","caller":"traceutil/trace.go:171","msg":"trace[898015072] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:598; }","duration":"152.017566ms","start":"2026-02-26T04:08:27.323721Z","end":"2026-02-26T04:08:27.475739Z","steps":["trace[898015072] 'agreement among raft nodes before linearized reading' (duration: 151.626391ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:08:28.031416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.495142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T04:08:28.031624Z","caller":"traceutil/trace.go:171","msg":"trace[406760245] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:599; }","duration":"451.740116ms","start":"2026-02-26T04:08:27.57983Z","end":"2026-02-26T04:08:28.03157Z","steps":["trace[406760245] 'range keys from in-memory index tree' (duration: 451.407552ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:08:28.03169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:08:27.579814Z","time spent":"451.864587ms","remote":"127.0.0.1:43708","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-26T04:08:28.090924Z","caller":"traceutil/trace.go:171","msg":"trace[327475528] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"273.924051ms","start":"2026-02-26T04:08:27.816971Z","end":"2026-02-26T04:08:28.090895Z","steps":["trace[327475528] 'read index received' (duration: 273.541076ms)","trace[327475528] 'applied index is now lower than readState.Index' (duration: 381.345µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T04:08:28.091063Z","caller":"traceutil/trace.go:171","msg":"trace[60402284] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"485.012302ms","start":"2026-02-26T04:08:27.606007Z","end":"2026-02-26T04:08:28.09102Z","steps":["trace[60402284] 'process raft request' (duration: 484.571737ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:08:28.091191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.209464ms","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-26T04:08:28.091432Z","caller":"traceutil/trace.go:171","msg":"trace[947296583] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:600; }","duration":"274.516627ms","start":"2026-02-26T04:08:27.816902Z","end":"2026-02-26T04:08:28.091419Z","steps":["trace[947296583] 'agreement among raft nodes before linearized reading' (duration: 274.145473ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:08:28.092016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:08:27.605973Z","time spent":"485.380937ms","remote":"127.0.0.1:43742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188471,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T04:08:28.138547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.074243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-26T04:08:28.138616Z","caller":"traceutil/trace.go:171","msg":"trace[1783624837] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:600; }","duration":"315.208894ms","start":"2026-02-26T04:08:27.823391Z","end":"2026-02-26T04:08:28.1386Z","steps":["trace[1783624837] 'agreement among raft nodes before linearized reading' (duration: 314.972231ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:08:28.138649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:08:27.823364Z","time spent":"315.279664ms","remote":"127.0.0.1:43938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-26T04:08:28.138716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.768379ms","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-26T04:08:28.138775Z","caller":"traceutil/trace.go:171","msg":"trace[51876921] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:601; }","duration":"314.894539ms","start":"2026-02-26T04:08:27.823864Z","end":"2026-02-26T04:08:28.138758Z","steps":["trace[51876921] 'agreement among raft nodes before linearized reading' (duration: 314.657877ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:08:28.138792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.031182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-02-26T04:08:28.138805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:08:27.823836Z","time spent":"314.963871ms","remote":"127.0.0.1:43938","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":"info","ts":"2026-02-26T04:08:28.138808Z","caller":"traceutil/trace.go:171","msg":"trace[1965365412] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:601; }","duration":"315.060722ms","start":"2026-02-26T04:08:27.823741Z","end":"2026-02-26T04:08:28.138802Z","steps":["trace[1965365412] 'agreement among raft nodes before linearized reading' (duration: 315.008771ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:08:28.138827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:08:27.823735Z","time spent":"315.089102ms","remote":"127.0.0.1:43938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-26T04:08:28.138971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.47389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188486"} {"level":"info","ts":"2026-02-26T04:08:28.138994Z","caller":"traceutil/trace.go:171","msg":"trace[198033816] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:601; }","duration":"116.569061ms","start":"2026-02-26T04:08:28.022418Z","end":"2026-02-26T04:08:28.138987Z","steps":["trace[198033816] 'agreement among raft nodes before linearized reading' (duration: 116.45014ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:08:28.138973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.929185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T04:08:28.139041Z","caller":"traceutil/trace.go:171","msg":"trace[1382120409] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:601; }","duration":"106.060447ms","start":"2026-02-26T04:08:28.032963Z","end":"2026-02-26T04:08:28.139024Z","steps":["trace[1382120409] 'agreement among raft nodes before linearized reading' (duration: 105.952895ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:08:28.139141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.887931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-26T04:08:28.13931Z","caller":"traceutil/trace.go:171","msg":"trace[834472248] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:601; }","duration":"115.124395ms","start":"2026-02-26T04:08:28.024151Z","end":"2026-02-26T04:08:28.139276Z","steps":["trace[834472248] 'agreement among raft nodes before linearized reading' (duration: 114.294495ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:08:42.407791Z","caller":"traceutil/trace.go:171","msg":"trace[1219859120] transaction","detail":"{read_only:false; number_of_response:1; response_revision:722; }","duration":"163.204929ms","start":"2026-02-26T04:08:42.244555Z","end":"2026-02-26T04:08:42.40776Z","steps":["trace[1219859120] 'process raft request' (duration: 135.41084ms)","trace[1219859120] 'compare' (duration: 27.715118ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T04:08:42.441691Z","caller":"traceutil/trace.go:171","msg":"trace[1463527785] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"193.953223ms","start":"2026-02-26T04:08:42.247696Z","end":"2026-02-26T04:08:42.441649Z","steps":["trace[1463527785] 'process raft request' (duration: 193.72849ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:08:42.441843Z","caller":"traceutil/trace.go:171","msg":"trace[1117943043] linearizableReadLoop","detail":"{readStateIndex:749; appliedIndex:746; }","duration":"187.189063ms","start":"2026-02-26T04:08:42.254619Z","end":"2026-02-26T04:08:42.441808Z","steps":["trace[1117943043] 'read index received' (duration: 125.354031ms)","trace[1117943043] 'applied index is now lower than readState.Index' (duration: 61.833182ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T04:08:42.442204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.408385ms","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-26T04:08:42.442316Z","caller":"traceutil/trace.go:171","msg":"trace[742402575] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:724; }","duration":"187.72371ms","start":"2026-02-26T04:08:42.254573Z","end":"2026-02-26T04:08:42.442296Z","steps":["trace[742402575] 'agreement among raft nodes before linearized reading' (duration: 187.348505ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:08:42.441889Z","caller":"traceutil/trace.go:171","msg":"trace[1472525823] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"187.357154ms","start":"2026-02-26T04:08:42.254508Z","end":"2026-02-26T04:08:42.441865Z","steps":["trace[1472525823] 'process raft request' (duration: 187.097841ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:08:42.47236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.813422ms","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-26T04:08:42.472411Z","caller":"traceutil/trace.go:171","msg":"trace[1723277413] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:726; }","duration":"171.909793ms","start":"2026-02-26T04:08:42.300488Z","end":"2026-02-26T04:08:42.472398Z","steps":["trace[1723277413] 'agreement among raft nodes before linearized reading' (duration: 171.766852ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:08:43.134491Z","caller":"traceutil/trace.go:171","msg":"trace[1354259895] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"114.507424ms","start":"2026-02-26T04:08:43.019959Z","end":"2026-02-26T04:08:43.134467Z","steps":["trace[1354259895] 'process raft request' (duration: 114.355972ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:08:45.799421Z","caller":"traceutil/trace.go:171","msg":"trace[1580198359] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"211.050102ms","start":"2026-02-26T04:08:45.588345Z","end":"2026-02-26T04:08:45.799395Z","steps":["trace[1580198359] 'process raft request' (duration: 210.85887ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:09:04.749699Z","caller":"traceutil/trace.go:171","msg":"trace[911011345] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"128.713165ms","start":"2026-02-26T04:09:04.620958Z","end":"2026-02-26T04:09:04.749671Z","steps":["trace[911011345] 'process raft request' (duration: 86.160397ms)","trace[911011345] 'compare' (duration: 42.392826ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T04:09:37.70257Z","caller":"traceutil/trace.go:171","msg":"trace[1835516537] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"125.756925ms","start":"2026-02-26T04:09:37.576776Z","end":"2026-02-26T04:09:37.702533Z","steps":["trace[1835516537] 'process raft request' (duration: 125.578333ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:09:46.60486Z","caller":"traceutil/trace.go:171","msg":"trace[557015496] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"417.242476ms","start":"2026-02-26T04:09:46.187585Z","end":"2026-02-26T04:09:46.604828Z","steps":["trace[557015496] 'process raft request' (duration: 416.929423ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:09:46.605048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:09:46.187551Z","time spent":"417.389817ms","remote":"127.0.0.1:43938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T04:09:55.317355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.612272ms","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-26T04:09:55.317443Z","caller":"traceutil/trace.go:171","msg":"trace[1563998092] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:966; }","duration":"273.750613ms","start":"2026-02-26T04:09:55.043671Z","end":"2026-02-26T04:09:55.317422Z","steps":["trace[1563998092] 'range keys from in-memory index tree' (duration: 273.354789ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:09:55.317496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.475468ms","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-26T04:09:55.31755Z","caller":"traceutil/trace.go:171","msg":"trace[2034960117] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:966; }","duration":"232.578479ms","start":"2026-02-26T04:09:55.084958Z","end":"2026-02-26T04:09:55.317537Z","steps":["trace[2034960117] 'range keys from in-memory index tree' (duration: 232.314256ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:09:55.317569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.280041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-26T04:09:55.317671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.924184ms","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-26T04:09:55.317699Z","caller":"traceutil/trace.go:171","msg":"trace[1098561238] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:966; }","duration":"236.465964ms","start":"2026-02-26T04:09:55.081195Z","end":"2026-02-26T04:09:55.31766Z","steps":["trace[1098561238] 'range keys from in-memory index tree' (duration: 236.023989ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T04:09:55.317753Z","caller":"traceutil/trace.go:171","msg":"trace[1158955296] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:966; }","duration":"444.041606ms","start":"2026-02-26T04:09:54.873688Z","end":"2026-02-26T04:09:55.31773Z","steps":["trace[1158955296] 'range keys from in-memory index tree' (duration: 443.722292ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T04:09:55.317817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T04:09:54.873671Z","time spent":"444.131887ms","remote":"127.0.0.1:43938","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\" "}