{"level":"warn","ts":"2026-04-10T04:09:56.0652Z","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-10T04:09:56.065276Z","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-04-10T04:09:56.065335Z","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-10T04:09:56.065342Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-04-10T04:09:56.065359Z","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-10T04:09:56.066527Z","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-04-10T04:09:56.066689Z","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-04-10T04:09:56.073755Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.839994ms"} {"level":"info","ts":"2026-04-10T04:09:56.084755Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a31e123290fcf0df","cluster-id":"37661d6ee45ed9e8"} {"level":"info","ts":"2026-04-10T04:09:56.084832Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=()"} {"level":"info","ts":"2026-04-10T04:09:56.084856Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 0"} {"level":"info","ts":"2026-04-10T04:09:56.084864Z","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-04-10T04:09:56.084876Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 1"} {"level":"info","ts":"2026-04-10T04:09:56.08491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"warn","ts":"2026-04-10T04:09:56.091826Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-10T04:09:56.094191Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-10T04:09:56.095837Z","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-10T04:09:56.097926Z","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-04-10T04:09:56.098392Z","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-10T04:09:56.09853Z","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-10T04:09:56.09856Z","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-10T04:09:56.098394Z","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-04-10T04:09:56.101244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"info","ts":"2026-04-10T04:09:56.101327Z","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-04-10T04:09:56.102156Z","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-10T04:09:56.10232Z","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-04-10T04:09:56.102345Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-10T04:09:56.10243Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-04-10T04:09:56.102443Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-04-10T04:09:56.685384Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df is starting a new election at term 1"} {"level":"info","ts":"2026-04-10T04:09:56.685512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became pre-candidate at term 1"} {"level":"info","ts":"2026-04-10T04:09:56.685587Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgPreVoteResp from a31e123290fcf0df at term 1"} {"level":"info","ts":"2026-04-10T04:09:56.685643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became candidate at term 2"} {"level":"info","ts":"2026-04-10T04:09:56.685679Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgVoteResp from a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-04-10T04:09:56.685725Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became leader at term 2"} {"level":"info","ts":"2026-04-10T04:09:56.685763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a31e123290fcf0df elected leader a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-04-10T04:09:56.687336Z","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-04-10T04:09:56.687543Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-10T04:09:56.687628Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-10T04:09:56.687699Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T04:09:56.687882Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-10T04:09:56.687931Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-10T04:09:56.690375Z","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-04-10T04:09:56.690492Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T04:09:56.690531Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T04:09:56.693416Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-10T04:09:56.697778Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.113:2379"} {"level":"warn","ts":"2026-04-10T04:09:56.898391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.170687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-10T04:09:56.898464Z","caller":"traceutil/trace.go:171","msg":"trace[2121852074] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"108.28175ms","start":"2026-04-10T04:09:56.79017Z","end":"2026-04-10T04:09:56.898451Z","steps":["trace[2121852074] 'count revisions from in-memory index tree' (duration: 108.131046ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:02.872754Z","caller":"traceutil/trace.go:171","msg":"trace[195177942] linearizableReadLoop","detail":"{readStateIndex:320; appliedIndex:319; }","duration":"500.172714ms","start":"2026-04-10T04:10:02.372542Z","end":"2026-04-10T04:10:02.872714Z","steps":["trace[195177942] 'read index received' (duration: 499.959228ms)","trace[195177942] 'applied index is now lower than readState.Index' (duration: 211.986µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:10:02.872839Z","caller":"traceutil/trace.go:171","msg":"trace[1937017424] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"661.4756ms","start":"2026-04-10T04:10:02.211314Z","end":"2026-04-10T04:10:02.87279Z","steps":["trace[1937017424] 'process raft request' (duration: 661.13327ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:10:02.873024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.431772ms","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-10T04:10:02.873076Z","caller":"traceutil/trace.go:171","msg":"trace[1108222365] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:310; }","duration":"500.568976ms","start":"2026-04-10T04:10:02.372491Z","end":"2026-04-10T04:10:02.87306Z","steps":["trace[1108222365] 'agreement among raft nodes before linearized reading' (duration: 500.38119ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:10:02.873123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:10:02.372467Z","time spent":"500.646418ms","remote":"127.0.0.1:43648","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-10T04:10:02.873658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:10:02.211267Z","time spent":"661.670656ms","remote":"127.0.0.1:43596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":199,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T04:10:03.020972Z","caller":"traceutil/trace.go:171","msg":"trace[213211525] linearizableReadLoop","detail":"{readStateIndex:323; appliedIndex:322; }","duration":"148.099005ms","start":"2026-04-10T04:10:02.872845Z","end":"2026-04-10T04:10:03.020944Z","steps":["trace[213211525] 'read index received' (duration: 148.062924ms)","trace[213211525] 'applied index is now lower than readState.Index' (duration: 34.661µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:10:03.020989Z","caller":"traceutil/trace.go:171","msg":"trace[1849839907] transaction","detail":"{read_only:false; number_of_response:0; response_revision:310; }","duration":"397.724818ms","start":"2026-04-10T04:10:02.623219Z","end":"2026-04-10T04:10:03.020944Z","steps":["trace[1849839907] 'process raft request' (duration: 397.601195ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:03.021078Z","caller":"traceutil/trace.go:171","msg":"trace[1411426864] transaction","detail":"{read_only:false; number_of_response:0; response_revision:310; }","duration":"396.995876ms","start":"2026-04-10T04:10:02.624074Z","end":"2026-04-10T04:10:03.02107Z","steps":["trace[1411426864] 'process raft request' (duration: 396.818901ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:10:03.021178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:10:02.624047Z","time spent":"397.061988ms","remote":"127.0.0.1:43588","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T04:10:03.021189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:10:02.6232Z","time spent":"397.895834ms","remote":"127.0.0.1:43588","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T04:10:03.021451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.175401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T04:10:03.021473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.359827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T04:10:03.021509Z","caller":"traceutil/trace.go:171","msg":"trace[2021118741] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:310; }","duration":"562.450109ms","start":"2026-04-10T04:10:02.459047Z","end":"2026-04-10T04:10:03.021497Z","steps":["trace[2021118741] 'agreement among raft nodes before linearized reading' (duration: 562.386607ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:03.02151Z","caller":"traceutil/trace.go:171","msg":"trace[490027662] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:310; }","duration":"505.287914ms","start":"2026-04-10T04:10:02.516204Z","end":"2026-04-10T04:10:03.021492Z","steps":["trace[490027662] 'agreement among raft nodes before linearized reading' (duration: 505.186381ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:10:03.021532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:10:02.459023Z","time spent":"562.505121ms","remote":"127.0.0.1:43378","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-04-10T04:10:03.021544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:10:02.516175Z","time spent":"505.362236ms","remote":"127.0.0.1:43648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-10T04:10:03.021777Z","caller":"traceutil/trace.go:171","msg":"trace[883646661] transaction","detail":"{read_only:false; number_of_response:0; response_revision:310; }","duration":"396.876542ms","start":"2026-04-10T04:10:02.62489Z","end":"2026-04-10T04:10:03.021767Z","steps":["trace[883646661] 'process raft request' (duration: 396.023836ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:10:03.021839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:10:02.624881Z","time spent":"396.932844ms","remote":"127.0.0.1:43588","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T04:10:03.021916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.919974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5895"} {"level":"info","ts":"2026-04-10T04:10:03.021954Z","caller":"traceutil/trace.go:171","msg":"trace[947973978] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:310; }","duration":"399.014097ms","start":"2026-04-10T04:10:02.622932Z","end":"2026-04-10T04:10:03.021946Z","steps":["trace[947973978] 'agreement among raft nodes before linearized reading' (duration: 398.949285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:10:03.021975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:10:02.622904Z","time spent":"399.066149ms","remote":"127.0.0.1:43588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":5918,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"info","ts":"2026-04-10T04:10:03.168798Z","caller":"traceutil/trace.go:171","msg":"trace[1425510898] linearizableReadLoop","detail":"{readStateIndex:324; appliedIndex:323; }","duration":"147.730699ms","start":"2026-04-10T04:10:03.021036Z","end":"2026-04-10T04:10:03.168766Z","steps":["trace[1425510898] 'read index received' (duration: 147.651537ms)","trace[1425510898] 'applied index is now lower than readState.Index' (duration: 77.562µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:10:03.168899Z","caller":"traceutil/trace.go:171","msg":"trace[1347332088] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"290.297138ms","start":"2026-04-10T04:10:02.87856Z","end":"2026-04-10T04:10:03.168858Z","steps":["trace[1347332088] 'process raft request' (duration: 290.02707ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:10:03.169031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.000269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslicemirroring-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T04:10:03.16908Z","caller":"traceutil/trace.go:171","msg":"trace[1369158466] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslicemirroring-controller; range_end:; response_count:0; response_revision:311; }","duration":"291.116352ms","start":"2026-04-10T04:10:02.877948Z","end":"2026-04-10T04:10:03.169064Z","steps":["trace[1369158466] 'agreement among raft nodes before linearized reading' (duration: 290.979628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:10:03.169105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.259296ms","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-04-10T04:10:03.169209Z","caller":"traceutil/trace.go:171","msg":"trace[293336465] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:311; }","duration":"176.439352ms","start":"2026-04-10T04:10:02.992746Z","end":"2026-04-10T04:10:03.169185Z","steps":["trace[293336465] 'agreement among raft nodes before linearized reading' (duration: 176.178544ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:03.442757Z","caller":"traceutil/trace.go:171","msg":"trace[1196608583] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"412.912861ms","start":"2026-04-10T04:10:03.029808Z","end":"2026-04-10T04:10:03.44272Z","steps":["trace[1196608583] 'process raft request' (duration: 412.596231ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:10:03.442918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:10:03.029796Z","time spent":"413.047804ms","remote":"127.0.0.1:43648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T04:10:03.442927Z","caller":"traceutil/trace.go:171","msg":"trace[2066081515] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"376.761087ms","start":"2026-04-10T04:10:03.066111Z","end":"2026-04-10T04:10:03.442872Z","steps":["trace[2066081515] 'process raft request' (duration: 376.498329ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:03.443036Z","caller":"traceutil/trace.go:171","msg":"trace[390974589] linearizableReadLoop","detail":"{readStateIndex:326; appliedIndex:324; }","duration":"274.106869ms","start":"2026-04-10T04:10:03.168894Z","end":"2026-04-10T04:10:03.443001Z","steps":["trace[390974589] 'read index received' (duration: 273.506471ms)","trace[390974589] 'applied index is now lower than readState.Index' (duration: 597.498µs)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:10:03.443237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.772387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5513"} {"level":"info","ts":"2026-04-10T04:10:03.443282Z","caller":"traceutil/trace.go:171","msg":"trace[684161076] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:313; }","duration":"415.862459ms","start":"2026-04-10T04:10:03.027406Z","end":"2026-04-10T04:10:03.443269Z","steps":["trace[684161076] 'agreement among raft nodes before linearized reading' (duration: 415.741145ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:10:03.443328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:10:03.027398Z","time spent":"415.92004ms","remote":"127.0.0.1:43588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":5536,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"warn","ts":"2026-04-10T04:10:03.443354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:10:03.066076Z","time spent":"376.959703ms","remote":"127.0.0.1:43588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7288,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T04:10:03.443342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.929621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T04:10:03.443383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.888139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7302"} {"level":"warn","ts":"2026-04-10T04:10:03.443522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.041425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2920"} {"level":"info","ts":"2026-04-10T04:10:03.443461Z","caller":"traceutil/trace.go:171","msg":"trace[391031072] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:313; }","duration":"416.072146ms","start":"2026-04-10T04:10:03.027357Z","end":"2026-04-10T04:10:03.443429Z","steps":["trace[391031072] 'agreement among raft nodes before linearized reading' (duration: 415.823728ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:03.443604Z","caller":"traceutil/trace.go:171","msg":"trace[1255232663] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:313; }","duration":"416.157007ms","start":"2026-04-10T04:10:03.027429Z","end":"2026-04-10T04:10:03.443586Z","steps":["trace[1255232663] 'agreement among raft nodes before linearized reading' (duration: 415.995183ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:03.443603Z","caller":"traceutil/trace.go:171","msg":"trace[2129129654] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:313; }","duration":"416.142067ms","start":"2026-04-10T04:10:03.027394Z","end":"2026-04-10T04:10:03.443536Z","steps":["trace[2129129654] 'agreement among raft nodes before linearized reading' (duration: 415.699114ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:10:03.443631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:10:03.027302Z","time spent":"416.312962ms","remote":"127.0.0.1:43388","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-04-10T04:10:03.443665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:10:03.027411Z","time spent":"416.24104ms","remote":"127.0.0.1:43588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":2943,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"warn","ts":"2026-04-10T04:10:03.443692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:10:03.027374Z","time spent":"416.298512ms","remote":"127.0.0.1:43588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7325,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"warn","ts":"2026-04-10T04:10:03.444381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.784029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-10T04:10:03.444514Z","caller":"traceutil/trace.go:171","msg":"trace[1545086750] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:314; }","duration":"271.946664ms","start":"2026-04-10T04:10:03.172546Z","end":"2026-04-10T04:10:03.444493Z","steps":["trace[1545086750] 'agreement among raft nodes before linearized reading' (duration: 271.756698ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:03.444844Z","caller":"traceutil/trace.go:171","msg":"trace[1655641314] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"270.48692ms","start":"2026-04-10T04:10:03.174325Z","end":"2026-04-10T04:10:03.444812Z","steps":["trace[1655641314] 'process raft request' (duration: 269.906023ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:26.9759Z","caller":"traceutil/trace.go:171","msg":"trace[172398523] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"145.881392ms","start":"2026-04-10T04:10:26.829981Z","end":"2026-04-10T04:10:26.975862Z","steps":["trace[172398523] 'process raft request' (duration: 145.700828ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:26.982201Z","caller":"traceutil/trace.go:171","msg":"trace[522318148] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"109.415915ms","start":"2026-04-10T04:10:26.872764Z","end":"2026-04-10T04:10:26.98218Z","steps":["trace[522318148] 'process raft request' (duration: 109.380424ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:26.982472Z","caller":"traceutil/trace.go:171","msg":"trace[849749045] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"148.508922ms","start":"2026-04-10T04:10:26.833954Z","end":"2026-04-10T04:10:26.982463Z","steps":["trace[849749045] 'process raft request' (duration: 147.790553ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:26.982583Z","caller":"traceutil/trace.go:171","msg":"trace[1010951427] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"148.449171ms","start":"2026-04-10T04:10:26.834124Z","end":"2026-04-10T04:10:26.982573Z","steps":["trace[1010951427] 'process raft request' (duration: 147.715281ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:26.982697Z","caller":"traceutil/trace.go:171","msg":"trace[1117728019] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"138.438368ms","start":"2026-04-10T04:10:26.844251Z","end":"2026-04-10T04:10:26.982689Z","steps":["trace[1117728019] 'process raft request' (duration: 137.614636ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:26.983278Z","caller":"traceutil/trace.go:171","msg":"trace[760506182] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"138.222852ms","start":"2026-04-10T04:10:26.845012Z","end":"2026-04-10T04:10:26.983235Z","steps":["trace[760506182] 'process raft request' (duration: 136.915238ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:26.983304Z","caller":"traceutil/trace.go:171","msg":"trace[996940158] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"138.454788ms","start":"2026-04-10T04:10:26.844845Z","end":"2026-04-10T04:10:26.983299Z","steps":["trace[996940158] 'process raft request' (duration: 137.045641ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:26.983329Z","caller":"traceutil/trace.go:171","msg":"trace[814072785] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"136.171707ms","start":"2026-04-10T04:10:26.847152Z","end":"2026-04-10T04:10:26.983324Z","steps":["trace[814072785] 'process raft request' (duration: 134.806211ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:26.983356Z","caller":"traceutil/trace.go:171","msg":"trace[1256519473] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"134.777491ms","start":"2026-04-10T04:10:26.848575Z","end":"2026-04-10T04:10:26.983352Z","steps":["trace[1256519473] 'process raft request' (duration: 133.413595ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:26.983341Z","caller":"traceutil/trace.go:171","msg":"trace[1024140103] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"131.280569ms","start":"2026-04-10T04:10:26.852024Z","end":"2026-04-10T04:10:26.983304Z","steps":["trace[1024140103] 'process raft request' (duration: 130.012445ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:26.983393Z","caller":"traceutil/trace.go:171","msg":"trace[1857697789] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"127.926711ms","start":"2026-04-10T04:10:26.855461Z","end":"2026-04-10T04:10:26.983388Z","steps":["trace[1857697789] 'process raft request' (duration: 126.639357ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:33.272802Z","caller":"traceutil/trace.go:171","msg":"trace[806047798] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"266.457055ms","start":"2026-04-10T04:10:33.006319Z","end":"2026-04-10T04:10:33.272776Z","steps":["trace[806047798] 'process raft request' (duration: 264.997408ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:33.646308Z","caller":"traceutil/trace.go:171","msg":"trace[967420515] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:640; }","duration":"185.622162ms","start":"2026-04-10T04:10:33.460664Z","end":"2026-04-10T04:10:33.646287Z","steps":["trace[967420515] 'read index received' (duration: 110.435493ms)","trace[967420515] 'applied index is now lower than readState.Index' (duration: 75.186069ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:10:33.646399Z","caller":"traceutil/trace.go:171","msg":"trace[1855465101] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"232.758459ms","start":"2026-04-10T04:10:33.4136Z","end":"2026-04-10T04:10:33.646358Z","steps":["trace[1855465101] 'process raft request' (duration: 157.469578ms)","trace[1855465101] 'compare' (duration: 75.122347ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:10:33.646603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.798697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T04:10:33.64672Z","caller":"traceutil/trace.go:171","msg":"trace[1885191645] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:618; }","duration":"186.081595ms","start":"2026-04-10T04:10:33.460611Z","end":"2026-04-10T04:10:33.646692Z","steps":["trace[1885191645] 'agreement among raft nodes before linearized reading' (duration: 185.768877ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:10:34.583086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.616393ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T04:10:34.583198Z","caller":"traceutil/trace.go:171","msg":"trace[397396414] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"883.834359ms","start":"2026-04-10T04:10:33.699344Z","end":"2026-04-10T04:10:34.583178Z","steps":["trace[397396414] 'read index received' (duration: 423.789505ms)","trace[397396414] 'applied index is now lower than readState.Index' (duration: 460.043304ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:10:34.583274Z","caller":"traceutil/trace.go:171","msg":"trace[640527934] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"930.985956ms","start":"2026-04-10T04:10:33.652277Z","end":"2026-04-10T04:10:34.583263Z","steps":["trace[640527934] 'process raft request' (duration: 470.938042ms)","trace[640527934] 'compare' (duration: 459.520931ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:10:34.583336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:10:33.652264Z","time spent":"931.042317ms","remote":"127.0.0.1:43648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T04:10:34.583542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.162347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-682vb\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-10T04:10:34.583638Z","caller":"traceutil/trace.go:171","msg":"trace[314476230] range","detail":"{range_begin:/registry/pods/kube-system/cilium-682vb; range_end:; response_count:1; response_revision:620; }","duration":"884.296121ms","start":"2026-04-10T04:10:33.699312Z","end":"2026-04-10T04:10:34.583608Z","steps":["trace[314476230] 'agreement among raft nodes before linearized reading' (duration: 884.026104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:10:34.583687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:10:33.699298Z","time spent":"884.380942ms","remote":"127.0.0.1:43588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-682vb\" "} {"level":"info","ts":"2026-04-10T04:10:34.595602Z","caller":"traceutil/trace.go:171","msg":"trace[2096429744] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"812.121186ms","start":"2026-04-10T04:10:33.783452Z","end":"2026-04-10T04:10:34.595573Z","steps":["trace[2096429744] 'process raft request' (duration: 811.568882ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:10:34.595681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.700564ms","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-04-10T04:10:34.595711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:10:33.783426Z","time spent":"812.235799ms","remote":"127.0.0.1:43492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T04:10:34.595738Z","caller":"traceutil/trace.go:171","msg":"trace[2137753873] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:621; }","duration":"588.820237ms","start":"2026-04-10T04:10:34.006904Z","end":"2026-04-10T04:10:34.595725Z","steps":["trace[2137753873] 'agreement among raft nodes before linearized reading' (duration: 588.628292ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:10:34.595793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:10:34.006885Z","time spent":"588.89941ms","remote":"127.0.0.1:43648","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-04-10T04:10:34.595959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.140628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T04:10:34.596011Z","caller":"traceutil/trace.go:171","msg":"trace[2134313602] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:621; }","duration":"134.23045ms","start":"2026-04-10T04:10:34.461768Z","end":"2026-04-10T04:10:34.595998Z","steps":["trace[2134313602] 'agreement among raft nodes before linearized reading' (duration: 134.140438ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:36.027729Z","caller":"traceutil/trace.go:171","msg":"trace[265213871] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:666; }","duration":"170.696321ms","start":"2026-04-10T04:10:35.857018Z","end":"2026-04-10T04:10:36.027714Z","steps":["trace[265213871] 'read index received' (duration: 170.569048ms)","trace[265213871] 'applied index is now lower than readState.Index' (duration: 126.583µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T04:10:36.027767Z","caller":"traceutil/trace.go:171","msg":"trace[2132490565] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"182.165049ms","start":"2026-04-10T04:10:35.845587Z","end":"2026-04-10T04:10:36.027752Z","steps":["trace[2132490565] 'process raft request' (duration: 182.034116ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:10:36.027876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.838015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T04:10:36.027913Z","caller":"traceutil/trace.go:171","msg":"trace[1058079980] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:643; }","duration":"170.888846ms","start":"2026-04-10T04:10:35.857014Z","end":"2026-04-10T04:10:36.027903Z","steps":["trace[1058079980] 'agreement among raft nodes before linearized reading' (duration: 170.801184ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:10:36.028046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.952107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T04:10:36.0281Z","caller":"traceutil/trace.go:171","msg":"trace[67123051] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:643; }","duration":"171.03323ms","start":"2026-04-10T04:10:35.857055Z","end":"2026-04-10T04:10:36.028088Z","steps":["trace[67123051] 'agreement among raft nodes before linearized reading' (duration: 170.930127ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:10:36.028774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.275631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T04:10:36.028829Z","caller":"traceutil/trace.go:171","msg":"trace[544438031] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:643; }","duration":"139.336083ms","start":"2026-04-10T04:10:35.889475Z","end":"2026-04-10T04:10:36.028811Z","steps":["trace[544438031] 'agreement among raft nodes before linearized reading' (duration: 139.25115ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:10:36.028826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.659051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T04:10:36.028952Z","caller":"traceutil/trace.go:171","msg":"trace[1558882939] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:643; }","duration":"139.837794ms","start":"2026-04-10T04:10:35.889087Z","end":"2026-04-10T04:10:36.028925Z","steps":["trace[1558882939] 'agreement among raft nodes before linearized reading' (duration: 139.66454ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:10:36.028173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.530413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T04:10:36.029037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.112893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T04:10:36.029047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.809734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T04:10:36.029057Z","caller":"traceutil/trace.go:171","msg":"trace[483814996] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:643; }","duration":"114.434906ms","start":"2026-04-10T04:10:35.914609Z","end":"2026-04-10T04:10:36.029044Z","steps":["trace[483814996] 'agreement among raft nodes before linearized reading' (duration: 113.535564ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:36.029081Z","caller":"traceutil/trace.go:171","msg":"trace[1869020491] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:643; }","duration":"115.158734ms","start":"2026-04-10T04:10:35.913912Z","end":"2026-04-10T04:10:36.02907Z","steps":["trace[1869020491] 'agreement among raft nodes before linearized reading' (duration: 115.098083ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:36.029082Z","caller":"traceutil/trace.go:171","msg":"trace[1402424427] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:643; }","duration":"139.860845ms","start":"2026-04-10T04:10:35.889212Z","end":"2026-04-10T04:10:36.029073Z","steps":["trace[1402424427] 'agreement among raft nodes before linearized reading' (duration: 139.812924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:10:36.029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.99403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T04:10:36.029154Z","caller":"traceutil/trace.go:171","msg":"trace[79817441] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:643; }","duration":"115.149334ms","start":"2026-04-10T04:10:35.913994Z","end":"2026-04-10T04:10:36.029144Z","steps":["trace[79817441] 'agreement among raft nodes before linearized reading' (duration: 114.971419ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:49.834286Z","caller":"traceutil/trace.go:171","msg":"trace[821105705] linearizableReadLoop","detail":"{readStateIndex:807; appliedIndex:806; }","duration":"374.140931ms","start":"2026-04-10T04:10:49.460118Z","end":"2026-04-10T04:10:49.834259Z","steps":["trace[821105705] 'read index received' (duration: 373.982268ms)","trace[821105705] 'applied index is now lower than readState.Index' (duration: 157.473µs)"],"step_count":2} {"level":"warn","ts":"2026-04-10T04:10:49.834434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.301396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T04:10:49.834401Z","caller":"traceutil/trace.go:171","msg":"trace[910095134] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"593.23312ms","start":"2026-04-10T04:10:49.241143Z","end":"2026-04-10T04:10:49.834376Z","steps":["trace[910095134] 'process raft request' (duration: 592.964394ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:49.834484Z","caller":"traceutil/trace.go:171","msg":"trace[804848217] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:780; }","duration":"374.414408ms","start":"2026-04-10T04:10:49.460059Z","end":"2026-04-10T04:10:49.834474Z","steps":["trace[804848217] 'agreement among raft nodes before linearized reading' (duration: 374.322656ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:10:49.834558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:10:49.460035Z","time spent":"374.50583ms","remote":"127.0.0.1:43378","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-04-10T04:10:49.834599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T04:10:49.241114Z","time spent":"593.384914ms","remote":"127.0.0.1:43648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T04:10:49.93121Z","caller":"traceutil/trace.go:171","msg":"trace[1987681221] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"116.759856ms","start":"2026-04-10T04:10:49.81441Z","end":"2026-04-10T04:10:49.93117Z","steps":["trace[1987681221] 'process raft request' (duration: 116.52157ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:10:49.931422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.179414ms","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-10T04:10:49.931527Z","caller":"traceutil/trace.go:171","msg":"trace[1568333898] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:781; }","duration":"206.331908ms","start":"2026-04-10T04:10:49.725176Z","end":"2026-04-10T04:10:49.931508Z","steps":["trace[1568333898] 'agreement among raft nodes before linearized reading' (duration: 206.01037ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T04:10:49.931625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.47484ms","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-10T04:10:49.931619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.759303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.113\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-10T04:10:49.931684Z","caller":"traceutil/trace.go:171","msg":"trace[1767953641] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:781; }","duration":"214.569583ms","start":"2026-04-10T04:10:49.717101Z","end":"2026-04-10T04:10:49.93167Z","steps":["trace[1767953641] 'agreement among raft nodes before linearized reading' (duration: 214.0372ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T04:10:49.931745Z","caller":"traceutil/trace.go:171","msg":"trace[470568572] range","detail":"{range_begin:/registry/masterleases/199.204.45.113; range_end:; response_count:1; response_revision:781; }","duration":"251.968718ms","start":"2026-04-10T04:10:49.679758Z","end":"2026-04-10T04:10:49.931727Z","steps":["trace[470568572] 'agreement among raft nodes before linearized reading' (duration: 251.521638ms)"],"step_count":1}