{"level":"warn","ts":"2026-04-13T21:00:17.900001Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-13T21:00:17.900117Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.65: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.65:2380","--initial-cluster=instance=https://199.204.45.65:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.65:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.65: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-04-13T21:00:17.900287Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-13T21:00:17.900303Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.65:2380"]} {"level":"info","ts":"2026-04-13T21:00:17.900324Z","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-04-13T21:00:17.901111Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"]} {"level":"info","ts":"2026-04-13T21:00:17.901228Z","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.65:2380"],"listen-peer-urls":["https://199.204.45.65:2380"],"advertise-client-urls":["https://199.204.45.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.65: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-04-13T21:00:17.905639Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.164364ms"} {"level":"info","ts":"2026-04-13T21:00:17.914209Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cf8c3a138c9a77a2","cluster-id":"c278183e1f634dff"} {"level":"info","ts":"2026-04-13T21:00:17.91432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=()"} {"level":"info","ts":"2026-04-13T21:00:17.914352Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 0"} {"level":"info","ts":"2026-04-13T21:00:17.91437Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cf8c3a138c9a77a2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-13T21:00:17.914382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 1"} {"level":"info","ts":"2026-04-13T21:00:17.914434Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"warn","ts":"2026-04-13T21:00:17.920667Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-13T21:00:17.922007Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-13T21:00:17.923095Z","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-04-13T21:00:17.925439Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cf8c3a138c9a77a2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-13T21:00:17.925665Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cf8c3a138c9a77a2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-13T21:00:17.925738Z","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-04-13T21:00:17.925802Z","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-04-13T21:00:17.925814Z","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-04-13T21:00:17.926663Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"info","ts":"2026-04-13T21:00:17.926848Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c278183e1f634dff","local-member-id":"cf8c3a138c9a77a2","added-peer-id":"cf8c3a138c9a77a2","added-peer-peer-urls":["https://199.204.45.65:2380"]} {"level":"info","ts":"2026-04-13T21:00:17.931348Z","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-04-13T21:00:17.931495Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-04-13T21:00:17.931542Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-04-13T21:00:17.931674Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cf8c3a138c9a77a2","initial-advertise-peer-urls":["https://199.204.45.65:2380"],"listen-peer-urls":["https://199.204.45.65:2380"],"advertise-client-urls":["https://199.204.45.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-13T21:00:17.931734Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-13T21:00:18.715431Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 is starting a new election at term 1"} {"level":"info","ts":"2026-04-13T21:00:18.715494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-13T21:00:18.715537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgPreVoteResp from cf8c3a138c9a77a2 at term 1"} {"level":"info","ts":"2026-04-13T21:00:18.715556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became candidate at term 2"} {"level":"info","ts":"2026-04-13T21:00:18.715567Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgVoteResp from cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-04-13T21:00:18.715592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became leader at term 2"} {"level":"info","ts":"2026-04-13T21:00:18.715606Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cf8c3a138c9a77a2 elected leader cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-04-13T21:00:18.737477Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T21:00:18.738018Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T21:00:18.738723Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-13T21:00:18.738844Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-13T21:00:18.741362Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-13T21:00:18.746151Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T21:00:18.747914Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cf8c3a138c9a77a2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.65:2379]}","request-path":"/0/members/cf8c3a138c9a77a2/attributes","cluster-id":"c278183e1f634dff","publish-timeout":"7s"} {"level":"info","ts":"2026-04-13T21:00:18.749399Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.65:2379"} {"level":"info","ts":"2026-04-13T21:00:18.762437Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c278183e1f634dff","local-member-id":"cf8c3a138c9a77a2","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T21:00:18.76253Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T21:00:18.762548Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T21:00:21.20968Z","caller":"traceutil/trace.go:171","msg":"trace[2019015140] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"260.670331ms","start":"2026-04-13T21:00:20.948985Z","end":"2026-04-13T21:00:21.209655Z","steps":["trace[2019015140] 'process raft request' (duration: 260.543153ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:21.252751Z","caller":"traceutil/trace.go:171","msg":"trace[1174188696] linearizableReadLoop","detail":"{readStateIndex:77; appliedIndex:75; }","duration":"232.225053ms","start":"2026-04-13T21:00:21.020496Z","end":"2026-04-13T21:00:21.252721Z","steps":["trace[1174188696] 'read index received' (duration: 189.089812ms)","trace[1174188696] 'applied index is now lower than readState.Index' (duration: 43.134361ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:00:21.25288Z","caller":"traceutil/trace.go:171","msg":"trace[575630056] transaction","detail":"{read_only:false; response_revision:73; number_of_response:1; }","duration":"273.912319ms","start":"2026-04-13T21:00:20.978919Z","end":"2026-04-13T21:00:21.252831Z","steps":["trace[575630056] 'process raft request' (duration: 273.674024ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:21.253579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.062436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T21:00:21.254284Z","caller":"traceutil/trace.go:171","msg":"trace[1352238398] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:73; }","duration":"233.259559ms","start":"2026-04-13T21:00:21.020401Z","end":"2026-04-13T21:00:21.25366Z","steps":["trace[1352238398] 'agreement among raft nodes before linearized reading' (duration: 232.518932ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:21.850219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.305661ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-13T21:00:21.850321Z","caller":"traceutil/trace.go:171","msg":"trace[1609840016] linearizableReadLoop","detail":"{readStateIndex:78; appliedIndex:77; }","duration":"593.646196ms","start":"2026-04-13T21:00:21.25666Z","end":"2026-04-13T21:00:21.850306Z","steps":["trace[1609840016] 'read index received' (duration: 354.805782ms)","trace[1609840016] 'applied index is now lower than readState.Index' (duration: 238.839224ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:00:21.850397Z","caller":"traceutil/trace.go:171","msg":"trace[1714752569] transaction","detail":"{read_only:false; response_revision:74; number_of_response:1; }","duration":"593.819687ms","start":"2026-04-13T21:00:21.256567Z","end":"2026-04-13T21:00:21.850387Z","steps":["trace[1714752569] 'process raft request' (duration: 354.885287ms)","trace[1714752569] 'compare' (duration: 238.197653ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:00:21.850442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:21.256542Z","time spent":"593.87717ms","remote":"127.0.0.1:56508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":634,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T21:00:21.850588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.077478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T21:00:21.850637Z","caller":"traceutil/trace.go:171","msg":"trace[762216912] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:74; }","duration":"360.167753ms","start":"2026-04-13T21:00:21.490454Z","end":"2026-04-13T21:00:21.850622Z","steps":["trace[762216912] 'agreement among raft nodes before linearized reading' (duration: 360.034865ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:21.85067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:21.490436Z","time spent":"360.226168ms","remote":"127.0.0.1:56276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "} {"level":"warn","ts":"2026-04-13T21:00:21.8507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.038331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T21:00:21.850735Z","caller":"traceutil/trace.go:171","msg":"trace[1343063055] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:74; }","duration":"594.106676ms","start":"2026-04-13T21:00:21.256618Z","end":"2026-04-13T21:00:21.850725Z","steps":["trace[1343063055] 'agreement among raft nodes before linearized reading' (duration: 594.057033ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:21.85076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:21.256598Z","time spent":"594.157169ms","remote":"127.0.0.1:56132","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-04-13T21:00:22.333809Z","caller":"traceutil/trace.go:171","msg":"trace[1803241997] linearizableReadLoop","detail":"{readStateIndex:79; appliedIndex:78; }","duration":"479.903823ms","start":"2026-04-13T21:00:21.853876Z","end":"2026-04-13T21:00:22.333779Z","steps":["trace[1803241997] 'read index received' (duration: 479.683289ms)","trace[1803241997] 'applied index is now lower than readState.Index' (duration: 219.354µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:00:22.333904Z","caller":"traceutil/trace.go:171","msg":"trace[1123510424] transaction","detail":"{read_only:false; response_revision:75; number_of_response:1; }","duration":"480.484051ms","start":"2026-04-13T21:00:21.853387Z","end":"2026-04-13T21:00:22.333871Z","steps":["trace[1123510424] 'process raft request' (duration: 480.204793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:22.334036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:21.853367Z","time spent":"480.602128ms","remote":"127.0.0.1:56320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T21:00:22.33404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.133268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:monitoring\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T21:00:22.334124Z","caller":"traceutil/trace.go:171","msg":"trace[485568698] range","detail":"{range_begin:/registry/clusterroles/system:monitoring; range_end:; response_count:0; response_revision:75; }","duration":"480.251466ms","start":"2026-04-13T21:00:21.853854Z","end":"2026-04-13T21:00:22.334106Z","steps":["trace[485568698] 'agreement among raft nodes before linearized reading' (duration: 480.037342ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:22.334159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:21.853847Z","time spent":"480.304309ms","remote":"127.0.0.1:56508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/system:monitoring\" "} {"level":"warn","ts":"2026-04-13T21:00:22.346793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.515126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T21:00:22.346874Z","caller":"traceutil/trace.go:171","msg":"trace[478999842] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:76; }","duration":"325.630533ms","start":"2026-04-13T21:00:22.021221Z","end":"2026-04-13T21:00:22.346852Z","steps":["trace[478999842] 'agreement among raft nodes before linearized reading' (duration: 325.507545ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:22.346913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:22.021201Z","time spent":"325.704208ms","remote":"127.0.0.1:56140","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-04-13T21:00:22.346798Z","caller":"traceutil/trace.go:171","msg":"trace[1268914957] transaction","detail":"{read_only:false; response_revision:76; number_of_response:1; }","duration":"164.089984ms","start":"2026-04-13T21:00:22.18269Z","end":"2026-04-13T21:00:22.34678Z","steps":["trace[1268914957] 'process raft request' (duration: 163.913572ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:26.458561Z","caller":"traceutil/trace.go:171","msg":"trace[1897793041] transaction","detail":"{read_only:false; response_revision:329; number_of_response:1; }","duration":"100.325386ms","start":"2026-04-13T21:00:26.358204Z","end":"2026-04-13T21:00:26.458529Z","steps":["trace[1897793041] 'process raft request' (duration: 68.190131ms)","trace[1897793041] 'compare' (duration: 31.943953ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:00:27.790434Z","caller":"traceutil/trace.go:171","msg":"trace[949652453] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"113.941551ms","start":"2026-04-13T21:00:27.676461Z","end":"2026-04-13T21:00:27.790403Z","steps":["trace[949652453] 'process raft request' (duration: 113.748538ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:28.419615Z","caller":"traceutil/trace.go:171","msg":"trace[1538740890] linearizableReadLoop","detail":"{readStateIndex:363; appliedIndex:361; }","duration":"112.277533ms","start":"2026-04-13T21:00:28.307309Z","end":"2026-04-13T21:00:28.419587Z","steps":["trace[1538740890] 'read index received' (duration: 61.337611ms)","trace[1538740890] 'applied index is now lower than readState.Index' (duration: 50.939002ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:00:28.419715Z","caller":"traceutil/trace.go:171","msg":"trace[774650183] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"120.758869ms","start":"2026-04-13T21:00:28.298921Z","end":"2026-04-13T21:00:28.41968Z","steps":["trace[774650183] 'process raft request' (duration: 111.364424ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:28.419793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.449483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-04-13T21:00:28.420195Z","caller":"traceutil/trace.go:171","msg":"trace[221361639] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:350; }","duration":"112.894703ms","start":"2026-04-13T21:00:28.307283Z","end":"2026-04-13T21:00:28.420178Z","steps":["trace[221361639] 'agreement among raft nodes before linearized reading' (duration: 112.406201ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:29.67319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.324838ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:00:29.673416Z","caller":"traceutil/trace.go:171","msg":"trace[1998188190] linearizableReadLoop","detail":"{readStateIndex:408; appliedIndex:406; }","duration":"283.477304ms","start":"2026-04-13T21:00:29.389924Z","end":"2026-04-13T21:00:29.673402Z","steps":["trace[1998188190] 'read index received' (duration: 127.772181ms)","trace[1998188190] 'applied index is now lower than readState.Index' (duration: 155.704423ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:00:29.673516Z","caller":"traceutil/trace.go:171","msg":"trace[1583058227] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"305.040474ms","start":"2026-04-13T21:00:29.368463Z","end":"2026-04-13T21:00:29.673504Z","steps":["trace[1583058227] 'process raft request' (duration: 149.220395ms)","trace[1583058227] 'compare' (duration: 154.909911ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:00:29.673594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:29.368439Z","time spent":"305.114529ms","remote":"127.0.0.1:56398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:00:29.673828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.276466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-13T21:00:29.67385Z","caller":"traceutil/trace.go:171","msg":"trace[439686137] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:395; }","duration":"122.34623ms","start":"2026-04-13T21:00:29.551497Z","end":"2026-04-13T21:00:29.673843Z","steps":["trace[439686137] 'agreement among raft nodes before linearized reading' (duration: 122.300957ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:29.673966Z","caller":"traceutil/trace.go:171","msg":"trace[313750700] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"305.004882ms","start":"2026-04-13T21:00:29.368919Z","end":"2026-04-13T21:00:29.673924Z","steps":["trace[313750700] 'process raft request' (duration: 304.36564ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:29.673889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.913641ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:00:29.674093Z","caller":"traceutil/trace.go:171","msg":"trace[99759760] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:395; }","duration":"284.146367ms","start":"2026-04-13T21:00:29.389914Z","end":"2026-04-13T21:00:29.674061Z","steps":["trace[99759760] 'agreement among raft nodes before linearized reading' (duration: 283.860049ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:29.674139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:29.368884Z","time spent":"305.160032ms","remote":"127.0.0.1:56398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:00:29.943109Z","caller":"traceutil/trace.go:171","msg":"trace[1831890893] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"243.525397ms","start":"2026-04-13T21:00:29.699555Z","end":"2026-04-13T21:00:29.94308Z","steps":["trace[1831890893] 'process raft request' (duration: 243.371707ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:43.883619Z","caller":"traceutil/trace.go:171","msg":"trace[474180756] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"146.382675ms","start":"2026-04-13T21:00:43.737208Z","end":"2026-04-13T21:00:43.88359Z","steps":["trace[474180756] 'process raft request' (duration: 146.233421ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:43.91008Z","caller":"traceutil/trace.go:171","msg":"trace[131708603] linearizableReadLoop","detail":"{readStateIndex:487; appliedIndex:485; }","duration":"101.462981ms","start":"2026-04-13T21:00:43.808588Z","end":"2026-04-13T21:00:43.910051Z","steps":["trace[131708603] 'read index received' (duration: 74.899885ms)","trace[131708603] 'applied index is now lower than readState.Index' (duration: 26.562146ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:00:43.910204Z","caller":"traceutil/trace.go:171","msg":"trace[380478859] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"171.867542ms","start":"2026-04-13T21:00:43.738296Z","end":"2026-04-13T21:00:43.910164Z","steps":["trace[380478859] 'process raft request' (duration: 171.631612ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:43.910351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.741519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-13T21:00:43.910395Z","caller":"traceutil/trace.go:171","msg":"trace[530916497] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:469; }","duration":"101.835646ms","start":"2026-04-13T21:00:43.808547Z","end":"2026-04-13T21:00:43.910382Z","steps":["trace[530916497] 'agreement among raft nodes before linearized reading' (duration: 101.617454ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:52.439922Z","caller":"traceutil/trace.go:171","msg":"trace[1819445071] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"109.017508ms","start":"2026-04-13T21:00:52.330876Z","end":"2026-04-13T21:00:52.439893Z","steps":["trace[1819445071] 'process raft request' (duration: 108.805804ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:52.448041Z","caller":"traceutil/trace.go:171","msg":"trace[2141888236] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"113.136667ms","start":"2026-04-13T21:00:52.334857Z","end":"2026-04-13T21:00:52.447993Z","steps":["trace[2141888236] 'process raft request' (duration: 112.960222ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:52.448116Z","caller":"traceutil/trace.go:171","msg":"trace[1272075128] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"113.110158ms","start":"2026-04-13T21:00:52.334945Z","end":"2026-04-13T21:00:52.448055Z","steps":["trace[1272075128] 'process raft request' (duration: 112.960392ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:52.448286Z","caller":"traceutil/trace.go:171","msg":"trace[465880366] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"106.399129ms","start":"2026-04-13T21:00:52.341876Z","end":"2026-04-13T21:00:52.448275Z","steps":["trace[465880366] 'process raft request' (duration: 106.140576ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:52.448362Z","caller":"traceutil/trace.go:171","msg":"trace[382202900] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"108.007385ms","start":"2026-04-13T21:00:52.340349Z","end":"2026-04-13T21:00:52.448356Z","steps":["trace[382202900] 'process raft request' (duration: 107.631416ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:52.448359Z","caller":"traceutil/trace.go:171","msg":"trace[2049773833] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"108.081594ms","start":"2026-04-13T21:00:52.340265Z","end":"2026-04-13T21:00:52.448347Z","steps":["trace[2049773833] 'process raft request' (duration: 107.678365ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:53.012005Z","caller":"traceutil/trace.go:171","msg":"trace[1260928227] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:597; }","duration":"162.724877ms","start":"2026-04-13T21:00:52.849245Z","end":"2026-04-13T21:00:53.01197Z","steps":["trace[1260928227] 'read index received' (duration: 161.977496ms)","trace[1260928227] 'applied index is now lower than readState.Index' (duration: 746.021µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:00:53.012092Z","caller":"traceutil/trace.go:171","msg":"trace[65033826] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"176.437337ms","start":"2026-04-13T21:00:52.835632Z","end":"2026-04-13T21:00:53.012069Z","steps":["trace[65033826] 'process raft request' (duration: 175.5746ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:53.012298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.007419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-13T21:00:53.01235Z","caller":"traceutil/trace.go:171","msg":"trace[135825947] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:574; }","duration":"163.133186ms","start":"2026-04-13T21:00:52.849199Z","end":"2026-04-13T21:00:53.012332Z","steps":["trace[135825947] 'agreement among raft nodes before linearized reading' (duration: 162.910451ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:53.019231Z","caller":"traceutil/trace.go:171","msg":"trace[1885854034] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"134.713588ms","start":"2026-04-13T21:00:52.884496Z","end":"2026-04-13T21:00:53.01921Z","steps":["trace[1885854034] 'process raft request' (duration: 134.63947ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:53.019932Z","caller":"traceutil/trace.go:171","msg":"trace[82185519] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"158.232887ms","start":"2026-04-13T21:00:52.861686Z","end":"2026-04-13T21:00:53.019919Z","steps":["trace[82185519] 'process raft request' (duration: 157.180704ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:56.254391Z","caller":"traceutil/trace.go:171","msg":"trace[350646104] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"593.601961ms","start":"2026-04-13T21:00:55.660746Z","end":"2026-04-13T21:00:56.254348Z","steps":["trace[350646104] 'process raft request' (duration: 593.019764ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:56.254601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:55.660705Z","time spent":"593.823286ms","remote":"127.0.0.1:56226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036023,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T21:00:56.254674Z","caller":"traceutil/trace.go:171","msg":"trace[2008467387] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:632; }","duration":"428.358135ms","start":"2026-04-13T21:00:55.826296Z","end":"2026-04-13T21:00:56.254654Z","steps":["trace[2008467387] 'read index received' (duration: 427.120852ms)","trace[2008467387] 'applied index is now lower than readState.Index' (duration: 1.234773ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:00:56.254958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.637259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:00:56.255076Z","caller":"traceutil/trace.go:171","msg":"trace[689153138] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:608; }","duration":"428.807015ms","start":"2026-04-13T21:00:55.826239Z","end":"2026-04-13T21:00:56.255046Z","steps":["trace[689153138] 'agreement among raft nodes before linearized reading' (duration: 428.524101ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:56.255128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:55.826218Z","time spent":"428.901902ms","remote":"127.0.0.1:56140","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-13T21:00:56.256817Z","caller":"traceutil/trace.go:171","msg":"trace[747486741] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"329.403267ms","start":"2026-04-13T21:00:55.927346Z","end":"2026-04-13T21:00:56.256749Z","steps":["trace[747486741] 'process raft request' (duration: 329.190421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:56.25695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.497635ms","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-04-13T21:00:56.256993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.093156ms","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-04-13T21:00:56.257002Z","caller":"traceutil/trace.go:171","msg":"trace[643249993] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:609; }","duration":"300.580924ms","start":"2026-04-13T21:00:55.956405Z","end":"2026-04-13T21:00:56.256986Z","steps":["trace[643249993] 'agreement among raft nodes before linearized reading' (duration: 300.433617ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:56.257006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:55.927324Z","time spent":"329.576192ms","remote":"127.0.0.1:56398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:00:56.257043Z","caller":"traceutil/trace.go:171","msg":"trace[1887631779] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:609; }","duration":"322.174444ms","start":"2026-04-13T21:00:55.934854Z","end":"2026-04-13T21:00:56.257028Z","steps":["trace[1887631779] 'agreement among raft nodes before linearized reading' (duration: 321.794782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:56.257046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:55.956392Z","time spent":"300.646521ms","remote":"127.0.0.1:56398","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-04-13T21:00:56.257028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.622573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-13T21:00:56.257076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:55.934841Z","time spent":"322.227213ms","remote":"127.0.0.1:56398","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-04-13T21:00:56.25712Z","caller":"traceutil/trace.go:171","msg":"trace[682376526] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:609; }","duration":"200.769209ms","start":"2026-04-13T21:00:56.056327Z","end":"2026-04-13T21:00:56.257096Z","steps":["trace[682376526] 'agreement among raft nodes before linearized reading' (duration: 200.478395ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:58.044872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.393797ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:00:58.044994Z","caller":"traceutil/trace.go:171","msg":"trace[1917992169] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:643; }","duration":"145.071041ms","start":"2026-04-13T21:00:57.899905Z","end":"2026-04-13T21:00:58.044976Z","steps":["trace[1917992169] 'read index received' (duration: 3.323221ms)","trace[1917992169] 'applied index is now lower than readState.Index' (duration: 141.74638ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:00:58.045188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.258287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:00:58.045221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.377391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:00:58.045249Z","caller":"traceutil/trace.go:171","msg":"trace[1519395670] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:619; }","duration":"145.364556ms","start":"2026-04-13T21:00:57.899866Z","end":"2026-04-13T21:00:58.04523Z","steps":["trace[1519395670] 'agreement among raft nodes before linearized reading' (duration: 145.213329ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:58.045273Z","caller":"traceutil/trace.go:171","msg":"trace[1528628130] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:619; }","duration":"123.470709ms","start":"2026-04-13T21:00:57.921788Z","end":"2026-04-13T21:00:58.045258Z","steps":["trace[1528628130] 'agreement among raft nodes before linearized reading' (duration: 123.343652ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:58.045803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.128501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:00:58.045838Z","caller":"traceutil/trace.go:171","msg":"trace[1867239570] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:619; }","duration":"131.20725ms","start":"2026-04-13T21:00:57.91462Z","end":"2026-04-13T21:00:58.045827Z","steps":["trace[1867239570] 'agreement among raft nodes before linearized reading' (duration: 131.145821ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:58.045839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.1844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:00:58.04594Z","caller":"traceutil/trace.go:171","msg":"trace[1869342109] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:619; }","duration":"131.348837ms","start":"2026-04-13T21:00:57.914569Z","end":"2026-04-13T21:00:58.045918Z","steps":["trace[1869342109] 'agreement among raft nodes before linearized reading' (duration: 131.20079ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:58.046107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.17856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:00:58.046178Z","caller":"traceutil/trace.go:171","msg":"trace[58058251] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:619; }","duration":"146.300917ms","start":"2026-04-13T21:00:57.899865Z","end":"2026-04-13T21:00:58.046166Z","steps":["trace[58058251] 'agreement among raft nodes before linearized reading' (duration: 145.221509ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:58.047133Z","caller":"traceutil/trace.go:171","msg":"trace[331055658] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"167.842409ms","start":"2026-04-13T21:00:57.877212Z","end":"2026-04-13T21:00:58.045054Z","steps":["trace[331055658] 'process raft request' (duration: 26.160418ms)","trace[331055658] 'compare' (duration: 141.21611ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:00:59.540488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.785477ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:00:59.540598Z","caller":"traceutil/trace.go:171","msg":"trace[1838770375] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"476.745455ms","start":"2026-04-13T21:00:59.063837Z","end":"2026-04-13T21:00:59.540582Z","steps":["trace[1838770375] 'read index received' (duration: 47.88016ms)","trace[1838770375] 'applied index is now lower than readState.Index' (duration: 428.864505ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:00:59.540743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.85358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:00:59.540795Z","caller":"traceutil/trace.go:171","msg":"trace[1138569049] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:630; }","duration":"486.907008ms","start":"2026-04-13T21:00:59.053857Z","end":"2026-04-13T21:00:59.540764Z","steps":["trace[1138569049] 'agreement among raft nodes before linearized reading' (duration: 486.80026ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:59.540746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.576144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:00:59.540754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.523694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5zrbn\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-04-13T21:00:59.540837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:59.053852Z","time spent":"486.975607ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"info","ts":"2026-04-13T21:00:59.540876Z","caller":"traceutil/trace.go:171","msg":"trace[2117733778] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5zrbn; range_end:; response_count:1; response_revision:630; }","duration":"479.651021ms","start":"2026-04-13T21:00:59.061201Z","end":"2026-04-13T21:00:59.540852Z","steps":["trace[2117733778] 'agreement among raft nodes before linearized reading' (duration: 479.422946ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:59.540867Z","caller":"traceutil/trace.go:171","msg":"trace[1107318464] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:630; }","duration":"486.720152ms","start":"2026-04-13T21:00:59.054118Z","end":"2026-04-13T21:00:59.540839Z","steps":["trace[1107318464] 'agreement among raft nodes before linearized reading' (duration: 486.507726ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:59.540944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:59.054111Z","time spent":"486.81676ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"info","ts":"2026-04-13T21:00:59.541077Z","caller":"traceutil/trace.go:171","msg":"trace[1694802647] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"479.715531ms","start":"2026-04-13T21:00:59.061337Z","end":"2026-04-13T21:00:59.541053Z","steps":["trace[1694802647] 'process raft request' (duration: 50.284616ms)","trace[1694802647] 'compare' (duration: 428.641979ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:00:59.541111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.634394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:00:59.541144Z","caller":"traceutil/trace.go:171","msg":"trace[417854648] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:630; }","duration":"449.707702ms","start":"2026-04-13T21:00:59.091425Z","end":"2026-04-13T21:00:59.541133Z","steps":["trace[417854648] 'agreement among raft nodes before linearized reading' (duration: 449.652343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:59.541134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.141519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:00:59.541181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:59.091406Z","time spent":"449.765961ms","remote":"127.0.0.1:50492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-13T21:00:59.541186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:59.061301Z","time spent":"479.825438ms","remote":"127.0.0.1:56520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T21:00:59.541212Z","caller":"traceutil/trace.go:171","msg":"trace[404079588] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:630; }","duration":"465.246296ms","start":"2026-04-13T21:00:59.075939Z","end":"2026-04-13T21:00:59.541185Z","steps":["trace[404079588] 'agreement among raft nodes before linearized reading' (duration: 465.123869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:59.541261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:59.075923Z","time spent":"465.323425ms","remote":"127.0.0.1:50490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-13T21:00:59.541358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.546675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:00:59.541372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.154144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:00:59.541394Z","caller":"traceutil/trace.go:171","msg":"trace[891914796] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:630; }","duration":"449.585005ms","start":"2026-04-13T21:00:59.091801Z","end":"2026-04-13T21:00:59.541386Z","steps":["trace[891914796] 'agreement among raft nodes before linearized reading' (duration: 449.532226ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:59.541407Z","caller":"traceutil/trace.go:171","msg":"trace[389121127] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:630; }","duration":"450.189273ms","start":"2026-04-13T21:00:59.091206Z","end":"2026-04-13T21:00:59.541396Z","steps":["trace[389121127] 'agreement among raft nodes before linearized reading' (duration: 450.130564ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:59.541428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:59.091779Z","time spent":"449.640523ms","remote":"127.0.0.1:50490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-04-13T21:00:59.541443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:59.09117Z","time spent":"450.264022ms","remote":"127.0.0.1:50492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-13T21:00:59.541515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.511281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:00:59.541588Z","caller":"traceutil/trace.go:171","msg":"trace[1649852720] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:630; }","duration":"465.57784ms","start":"2026-04-13T21:00:59.075981Z","end":"2026-04-13T21:00:59.541559Z","steps":["trace[1649852720] 'agreement among raft nodes before linearized reading' (duration: 465.496422ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:59.541643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:59.075977Z","time spent":"465.651089ms","remote":"127.0.0.1:50490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-13T21:00:59.541787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:59.061168Z","time spent":"479.74796ms","remote":"127.0.0.1:56320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-5zrbn\" "} {"level":"warn","ts":"2026-04-13T21:01:00.463582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.356118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:01:00.463677Z","caller":"traceutil/trace.go:171","msg":"trace[150428322] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:631; }","duration":"645.503616ms","start":"2026-04-13T21:00:59.818152Z","end":"2026-04-13T21:01:00.463656Z","steps":["trace[150428322] 'range keys from in-memory index tree' (duration: 645.285739ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:00.463719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:59.818134Z","time spent":"645.574434ms","remote":"127.0.0.1:56132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-13T21:01:00.596297Z","caller":"traceutil/trace.go:171","msg":"trace[1225357828] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:657; }","duration":"318.163574ms","start":"2026-04-13T21:01:00.278109Z","end":"2026-04-13T21:01:00.596272Z","steps":["trace[1225357828] 'read index received' (duration: 317.553065ms)","trace[1225357828] 'applied index is now lower than readState.Index' (duration: 609.629µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:01:00.596466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.333551ms","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-04-13T21:01:00.596553Z","caller":"traceutil/trace.go:171","msg":"trace[1989310132] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:632; }","duration":"318.485249ms","start":"2026-04-13T21:01:00.278049Z","end":"2026-04-13T21:01:00.596534Z","steps":["trace[1989310132] 'agreement among raft nodes before linearized reading' (duration: 318.320952ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:01:00.596395Z","caller":"traceutil/trace.go:171","msg":"trace[344487086] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"633.712784ms","start":"2026-04-13T21:00:59.962636Z","end":"2026-04-13T21:01:00.596348Z","steps":["trace[344487086] 'process raft request' (duration: 633.243452ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:00.596605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:01:00.278024Z","time spent":"318.569357ms","remote":"127.0.0.1:56398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-13T21:01:00.596723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:59.96261Z","time spent":"634.045088ms","remote":"127.0.0.1:56226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:01:00.596936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.07656ms","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-04-13T21:01:00.597009Z","caller":"traceutil/trace.go:171","msg":"trace[2030677901] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:632; }","duration":"316.174538ms","start":"2026-04-13T21:01:00.28082Z","end":"2026-04-13T21:01:00.596994Z","steps":["trace[2030677901] 'agreement among raft nodes before linearized reading' (duration: 315.923762ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:00.59705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:01:00.28081Z","time spent":"316.231887ms","remote":"127.0.0.1:56398","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-04-13T21:01:00.597402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.290399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-13T21:01:00.597457Z","caller":"traceutil/trace.go:171","msg":"trace[440452382] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:632; }","duration":"317.351818ms","start":"2026-04-13T21:01:00.280092Z","end":"2026-04-13T21:01:00.597444Z","steps":["trace[440452382] 'agreement among raft nodes before linearized reading' (duration: 316.628821ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:00.597647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:01:00.280037Z","time spent":"317.538995ms","remote":"127.0.0.1:56398","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-04-13T21:01:02.378565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.320469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:01:02.37866Z","caller":"traceutil/trace.go:171","msg":"trace[2026309630] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:679; }","duration":"101.434847ms","start":"2026-04-13T21:01:02.277205Z","end":"2026-04-13T21:01:02.37864Z","steps":["trace[2026309630] 'range keys from in-memory index tree' (duration: 101.197551ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:13.542134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.533685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.65\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-13T21:01:13.542254Z","caller":"traceutil/trace.go:171","msg":"trace[745243701] range","detail":"{range_begin:/registry/masterleases/199.204.45.65; range_end:; response_count:1; response_revision:782; }","duration":"316.680395ms","start":"2026-04-13T21:01:13.225552Z","end":"2026-04-13T21:01:13.542233Z","steps":["trace[745243701] 'range keys from in-memory index tree' (duration: 316.295186ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:13.542299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:01:13.225466Z","time spent":"316.823213ms","remote":"127.0.0.1:56166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.65\" "} {"level":"info","ts":"2026-04-13T21:01:16.119092Z","caller":"traceutil/trace.go:171","msg":"trace[942434983] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"169.676132ms","start":"2026-04-13T21:01:15.949386Z","end":"2026-04-13T21:01:16.119062Z","steps":["trace[942434983] 'process raft request' (duration: 168.431614ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:01:16.575739Z","caller":"traceutil/trace.go:171","msg":"trace[1239144901] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"388.418303ms","start":"2026-04-13T21:01:16.187284Z","end":"2026-04-13T21:01:16.575702Z","steps":["trace[1239144901] 'process raft request' (duration: 379.796103ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:01:16.575984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:01:16.187247Z","time spent":"388.589342ms","remote":"127.0.0.1:56388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:03:39.174313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.100736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cronjob-controller\" ","response":"range_response_count:1 size:201"} {"level":"info","ts":"2026-04-13T21:03:39.174413Z","caller":"traceutil/trace.go:171","msg":"trace[2051469584] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cronjob-controller; range_end:; response_count:1; response_revision:1442; }","duration":"105.234973ms","start":"2026-04-13T21:03:39.069159Z","end":"2026-04-13T21:03:39.174394Z","steps":["trace[2051469584] 'range keys from in-memory index tree' (duration: 104.98421ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:03:39.755238Z","caller":"traceutil/trace.go:171","msg":"trace[851996768] linearizableReadLoop","detail":"{readStateIndex:1509; appliedIndex:1508; }","duration":"127.003535ms","start":"2026-04-13T21:03:39.628209Z","end":"2026-04-13T21:03:39.755212Z","steps":["trace[851996768] 'read index received' (duration: 126.841257ms)","trace[851996768] 'applied index is now lower than readState.Index' (duration: 161.097µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:03:39.75537Z","caller":"traceutil/trace.go:171","msg":"trace[1032184144] transaction","detail":"{read_only:false; response_revision:1444; number_of_response:1; }","duration":"127.272298ms","start":"2026-04-13T21:03:39.628065Z","end":"2026-04-13T21:03:39.755337Z","steps":["trace[1032184144] 'process raft request' (duration: 127.008505ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:39.755497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.217645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-13T21:03:39.755675Z","caller":"traceutil/trace.go:171","msg":"trace[2022948233] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:1444; }","duration":"127.461797ms","start":"2026-04-13T21:03:39.628183Z","end":"2026-04-13T21:03:39.755645Z","steps":["trace[2022948233] 'agreement among raft nodes before linearized reading' (duration: 127.183243ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:03:39.771308Z","caller":"traceutil/trace.go:171","msg":"trace[2126512981] transaction","detail":"{read_only:false; response_revision:1445; number_of_response:1; }","duration":"143.105179ms","start":"2026-04-13T21:03:39.62818Z","end":"2026-04-13T21:03:39.771286Z","steps":["trace[2126512981] 'process raft request' (duration: 142.949602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:03:39.771878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.50545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/disruption-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-13T21:03:39.771915Z","caller":"traceutil/trace.go:171","msg":"trace[777220466] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/disruption-controller; range_end:; response_count:1; response_revision:1445; }","duration":"143.579763ms","start":"2026-04-13T21:03:39.628323Z","end":"2026-04-13T21:03:39.771903Z","steps":["trace[777220466] 'agreement among raft nodes before linearized reading' (duration: 143.505299ms)"],"step_count":1}