{"level":"warn","ts":"2026-05-15T08:07:51.648227Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-15T08:07:51.64835Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.134: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.19.213.134:2380","--initial-cluster=instance=https://199.19.213.134:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.134:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.134: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-05-15T08:07:51.648607Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-15T08:07:51.64863Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.134:2380"]} {"level":"info","ts":"2026-05-15T08:07:51.648657Z","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-05-15T08:07:51.649591Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.134:2379"]} {"level":"info","ts":"2026-05-15T08:07:51.650128Z","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.19.213.134:2380"],"listen-peer-urls":["https://199.19.213.134:2380"],"advertise-client-urls":["https://199.19.213.134:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.134:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.134: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-05-15T08:07:51.657109Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.631192ms"} {"level":"info","ts":"2026-05-15T08:07:51.668469Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"92da22d3868c86fb","cluster-id":"84450b28e935eb90"} {"level":"info","ts":"2026-05-15T08:07:51.668609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb switched to configuration voters=()"} {"level":"info","ts":"2026-05-15T08:07:51.668704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb became follower at term 0"} {"level":"info","ts":"2026-05-15T08:07:51.668734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 92da22d3868c86fb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-15T08:07:51.668754Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb became follower at term 1"} {"level":"info","ts":"2026-05-15T08:07:51.668821Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb switched to configuration voters=(10581808566351202043)"} {"level":"warn","ts":"2026-05-15T08:07:51.677268Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-15T08:07:51.678842Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-15T08:07:51.68027Z","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-05-15T08:07:51.682534Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"92da22d3868c86fb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-15T08:07:51.682766Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"92da22d3868c86fb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-15T08:07:51.682826Z","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-05-15T08:07:51.682905Z","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-05-15T08:07:51.682912Z","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-05-15T08:07:51.684773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb switched to configuration voters=(10581808566351202043)"} {"level":"info","ts":"2026-05-15T08:07:51.684906Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"84450b28e935eb90","local-member-id":"92da22d3868c86fb","added-peer-id":"92da22d3868c86fb","added-peer-peer-urls":["https://199.19.213.134:2380"]} {"level":"info","ts":"2026-05-15T08:07:51.686691Z","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-05-15T08:07:51.686889Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.134:2380"} {"level":"info","ts":"2026-05-15T08:07:51.686922Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.134:2380"} {"level":"info","ts":"2026-05-15T08:07:51.687192Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"92da22d3868c86fb","initial-advertise-peer-urls":["https://199.19.213.134:2380"],"listen-peer-urls":["https://199.19.213.134:2380"],"advertise-client-urls":["https://199.19.213.134:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.134:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-15T08:07:51.687234Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-15T08:07:51.869174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb is starting a new election at term 1"} {"level":"info","ts":"2026-05-15T08:07:51.869253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb became pre-candidate at term 1"} {"level":"info","ts":"2026-05-15T08:07:51.869297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb received MsgPreVoteResp from 92da22d3868c86fb at term 1"} {"level":"info","ts":"2026-05-15T08:07:51.869319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb became candidate at term 2"} {"level":"info","ts":"2026-05-15T08:07:51.869335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb received MsgVoteResp from 92da22d3868c86fb at term 2"} {"level":"info","ts":"2026-05-15T08:07:51.869353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb became leader at term 2"} {"level":"info","ts":"2026-05-15T08:07:51.869367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 92da22d3868c86fb elected leader 92da22d3868c86fb at term 2"} {"level":"info","ts":"2026-05-15T08:07:51.870705Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"92da22d3868c86fb","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.134:2379]}","request-path":"/0/members/92da22d3868c86fb/attributes","cluster-id":"84450b28e935eb90","publish-timeout":"7s"} {"level":"info","ts":"2026-05-15T08:07:51.87097Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-15T08:07:51.871151Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-15T08:07:51.871203Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-15T08:07:51.872572Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"84450b28e935eb90","local-member-id":"92da22d3868c86fb","cluster-version":"3.5"} {"level":"info","ts":"2026-05-15T08:07:51.872767Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-15T08:07:51.872809Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-15T08:07:51.874322Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-15T08:07:51.874806Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-15T08:07:51.874833Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-15T08:07:51.875584Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.134:2379"} {"level":"info","ts":"2026-05-15T08:07:54.826827Z","caller":"traceutil/trace.go:171","msg":"trace[384312100] linearizableReadLoop","detail":"{readStateIndex:121; appliedIndex:120; }","duration":"146.37831ms","start":"2026-05-15T08:07:54.680424Z","end":"2026-05-15T08:07:54.826803Z","steps":["trace[384312100] 'read index received' (duration: 146.097422ms)","trace[384312100] 'applied index is now lower than readState.Index' (duration: 279.628µs)"],"step_count":2} {"level":"info","ts":"2026-05-15T08:07:54.826957Z","caller":"traceutil/trace.go:171","msg":"trace[1807818758] transaction","detail":"{read_only:false; response_revision:116; number_of_response:1; }","duration":"148.293098ms","start":"2026-05-15T08:07:54.678655Z","end":"2026-05-15T08:07:54.826948Z","steps":["trace[1807818758] 'process raft request' (duration: 147.953548ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:07:54.82724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.493492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-15T08:07:54.827388Z","caller":"traceutil/trace.go:171","msg":"trace[976677000] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:116; }","duration":"137.72656ms","start":"2026-05-15T08:07:54.689632Z","end":"2026-05-15T08:07:54.827358Z","steps":["trace[976677000] 'agreement among raft nodes before linearized reading' (duration: 137.453031ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:07:54.827585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.067221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-view\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-15T08:07:54.827745Z","caller":"traceutil/trace.go:171","msg":"trace[1897189812] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-view; range_end:; response_count:0; response_revision:116; }","duration":"147.309888ms","start":"2026-05-15T08:07:54.680378Z","end":"2026-05-15T08:07:54.827688Z","steps":["trace[1897189812] 'agreement among raft nodes before linearized reading' (duration: 147.022049ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:07:55.450722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.864288ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-15T08:07:55.450883Z","caller":"traceutil/trace.go:171","msg":"trace[924099823] transaction","detail":"{read_only:false; response_revision:118; number_of_response:1; }","duration":"557.327765ms","start":"2026-05-15T08:07:54.893535Z","end":"2026-05-15T08:07:55.450863Z","steps":["trace[924099823] 'process raft request' (duration: 161.725215ms)","trace[924099823] 'compare' (duration: 394.682503ms)"],"step_count":2} {"level":"warn","ts":"2026-05-15T08:07:55.450968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:07:54.893519Z","time spent":"557.423439ms","remote":"127.0.0.1:60740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-15T08:07:59.457712Z","caller":"traceutil/trace.go:171","msg":"trace[1184764720] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"200.398535ms","start":"2026-05-15T08:07:59.257287Z","end":"2026-05-15T08:07:59.457685Z","steps":["trace[1184764720] 'process raft request' (duration: 200.147798ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:01.602135Z","caller":"traceutil/trace.go:171","msg":"trace[540004114] linearizableReadLoop","detail":"{readStateIndex:357; appliedIndex:356; }","duration":"145.791381ms","start":"2026-05-15T08:08:01.456252Z","end":"2026-05-15T08:08:01.602044Z","steps":["trace[540004114] 'read index received' (duration: 145.622486ms)","trace[540004114] 'applied index is now lower than readState.Index' (duration: 167.565µs)"],"step_count":2} {"level":"info","ts":"2026-05-15T08:08:01.602144Z","caller":"traceutil/trace.go:171","msg":"trace[674677635] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"162.035194ms","start":"2026-05-15T08:08:01.440042Z","end":"2026-05-15T08:08:01.602078Z","steps":["trace[674677635] 'process raft request' (duration: 161.846348ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:01.60239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.10838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-05-15T08:08:01.602455Z","caller":"traceutil/trace.go:171","msg":"trace[321058337] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:345; }","duration":"146.264635ms","start":"2026-05-15T08:08:01.456178Z","end":"2026-05-15T08:08:01.602442Z","steps":["trace[321058337] 'agreement among raft nodes before linearized reading' (duration: 146.09535ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:02.65466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.947756ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-15T08:08:02.654944Z","caller":"traceutil/trace.go:171","msg":"trace[309460174] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"434.719747ms","start":"2026-05-15T08:08:02.220184Z","end":"2026-05-15T08:08:02.654904Z","steps":["trace[309460174] 'process raft request' (duration: 267.426902ms)","trace[309460174] 'compare' (duration: 166.76122ms)"],"step_count":2} {"level":"warn","ts":"2026-05-15T08:08:02.655181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:02.220162Z","time spent":"434.943584ms","remote":"127.0.0.1:60674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1050,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-15T08:08:02.655195Z","caller":"traceutil/trace.go:171","msg":"trace[1350945654] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"434.502842ms","start":"2026-05-15T08:08:02.220673Z","end":"2026-05-15T08:08:02.655176Z","steps":["trace[1350945654] 'process raft request' (duration: 434.10663ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:02.655703Z","caller":"traceutil/trace.go:171","msg":"trace[2130594719] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"434.007978ms","start":"2026-05-15T08:08:02.221676Z","end":"2026-05-15T08:08:02.655683Z","steps":["trace[2130594719] 'process raft request' (duration: 433.426451ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:02.655733Z","caller":"traceutil/trace.go:171","msg":"trace[1595097040] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"394.1461ms","start":"2026-05-15T08:08:02.261569Z","end":"2026-05-15T08:08:02.655715Z","steps":["trace[1595097040] 'process raft request' (duration: 394.054768ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:02.655723Z","caller":"traceutil/trace.go:171","msg":"trace[661977437] linearizableReadLoop","detail":"{readStateIndex:374; appliedIndex:371; }","duration":"395.533971ms","start":"2026-05-15T08:08:02.26017Z","end":"2026-05-15T08:08:02.655704Z","steps":["trace[661977437] 'read index received' (duration: 227.612956ms)","trace[661977437] 'applied index is now lower than readState.Index' (duration: 167.918975ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T08:08:02.655891Z","caller":"traceutil/trace.go:171","msg":"trace[887623077] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"395.669465ms","start":"2026-05-15T08:08:02.260151Z","end":"2026-05-15T08:08:02.655821Z","steps":["trace[887623077] 'process raft request' (duration: 395.296423ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:02.656152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:02.221667Z","time spent":"434.09097ms","remote":"127.0.0.1:60570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4355,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-15T08:08:02.656111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.921302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-15T08:08:02.656235Z","caller":"traceutil/trace.go:171","msg":"trace[1342341461] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:364; }","duration":"396.092177ms","start":"2026-05-15T08:08:02.260125Z","end":"2026-05-15T08:08:02.656217Z","steps":["trace[1342341461] 'agreement among raft nodes before linearized reading' (duration: 395.856741ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:02.656378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.869395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-05-15T08:08:02.656383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:02.261558Z","time spent":"394.221092ms","remote":"127.0.0.1:60840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3691,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-15T08:08:02.656399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:02.260108Z","time spent":"396.20192ms","remote":"127.0.0.1:60458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":680,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-15T08:08:02.656506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:02.260092Z","time spent":"396.322153ms","remote":"127.0.0.1:60600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"info","ts":"2026-05-15T08:08:02.656695Z","caller":"traceutil/trace.go:171","msg":"trace[720437854] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:364; }","duration":"299.189245ms","start":"2026-05-15T08:08:02.357446Z","end":"2026-05-15T08:08:02.656635Z","steps":["trace[720437854] 'agreement among raft nodes before linearized reading' (duration: 298.883076ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:02.656045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:02.220633Z","time spent":"434.738248ms","remote":"127.0.0.1:60666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-15T08:08:02.656262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.022591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-15T08:08:02.656929Z","caller":"traceutil/trace.go:171","msg":"trace[1348049650] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:364; }","duration":"380.720151ms","start":"2026-05-15T08:08:02.276184Z","end":"2026-05-15T08:08:02.656904Z","steps":["trace[1348049650] 'agreement among raft nodes before linearized reading' (duration: 380.01841ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:02.656991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:02.276158Z","time spent":"380.818863ms","remote":"127.0.0.1:60666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-15T08:08:02.657076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.124244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-05-15T08:08:02.657208Z","caller":"traceutil/trace.go:171","msg":"trace[1965082477] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:364; }","duration":"349.299318ms","start":"2026-05-15T08:08:02.30789Z","end":"2026-05-15T08:08:02.657189Z","steps":["trace[1965082477] 'agreement among raft nodes before linearized reading' (duration: 349.073582ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:02.658172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:02.30786Z","time spent":"350.298148ms","remote":"127.0.0.1:60600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":258,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"warn","ts":"2026-05-15T08:08:02.657295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.975804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"} {"level":"info","ts":"2026-05-15T08:08:02.658397Z","caller":"traceutil/trace.go:171","msg":"trace[1925703951] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:364; }","duration":"375.097417ms","start":"2026-05-15T08:08:02.283256Z","end":"2026-05-15T08:08:02.658353Z","steps":["trace[1925703951] 'agreement among raft nodes before linearized reading' (duration: 373.971425ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:02.658921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:02.28323Z","time spent":"375.20161ms","remote":"127.0.0.1:60582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4350,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"info","ts":"2026-05-15T08:08:02.82812Z","caller":"traceutil/trace.go:171","msg":"trace[151399882] linearizableReadLoop","detail":"{readStateIndex:377; appliedIndex:376; }","duration":"164.215007ms","start":"2026-05-15T08:08:02.663863Z","end":"2026-05-15T08:08:02.828078Z","steps":["trace[151399882] 'read index received' (duration: 118.634244ms)","trace[151399882] 'applied index is now lower than readState.Index' (duration: 45.578863ms)"],"step_count":2} {"level":"warn","ts":"2026-05-15T08:08:02.828411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.458013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3706"} {"level":"info","ts":"2026-05-15T08:08:02.828456Z","caller":"traceutil/trace.go:171","msg":"trace[408489411] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:365; }","duration":"164.640719ms","start":"2026-05-15T08:08:02.663803Z","end":"2026-05-15T08:08:02.828444Z","steps":["trace[408489411] 'agreement among raft nodes before linearized reading' (duration: 164.405161ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:02.828645Z","caller":"traceutil/trace.go:171","msg":"trace[1739624761] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"165.73435ms","start":"2026-05-15T08:08:02.662591Z","end":"2026-05-15T08:08:02.828325Z","steps":["trace[1739624761] 'process raft request' (duration: 119.89299ms)","trace[1739624761] 'compare' (duration: 45.418088ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T08:08:02.828946Z","caller":"traceutil/trace.go:171","msg":"trace[146459163] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"162.651301ms","start":"2026-05-15T08:08:02.666278Z","end":"2026-05-15T08:08:02.828929Z","steps":["trace[146459163] 'process raft request' (duration: 162.501347ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:02.829219Z","caller":"traceutil/trace.go:171","msg":"trace[1323122642] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"161.93775ms","start":"2026-05-15T08:08:02.667239Z","end":"2026-05-15T08:08:02.829176Z","steps":["trace[1323122642] 'process raft request' (duration: 161.632312ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:02.829317Z","caller":"traceutil/trace.go:171","msg":"trace[1845058629] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"162.064324ms","start":"2026-05-15T08:08:02.667239Z","end":"2026-05-15T08:08:02.829303Z","steps":["trace[1845058629] 'process raft request' (duration: 161.871488ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:02.829538Z","caller":"traceutil/trace.go:171","msg":"trace[1199816774] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"162.191448ms","start":"2026-05-15T08:08:02.6673Z","end":"2026-05-15T08:08:02.829492Z","steps":["trace[1199816774] 'process raft request' (duration: 161.90667ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:02.831696Z","caller":"traceutil/trace.go:171","msg":"trace[580290598] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"162.313452ms","start":"2026-05-15T08:08:02.669361Z","end":"2026-05-15T08:08:02.831675Z","steps":["trace[580290598] 'process raft request' (duration: 162.202049ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:02.831772Z","caller":"traceutil/trace.go:171","msg":"trace[477761780] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"163.912998ms","start":"2026-05-15T08:08:02.667837Z","end":"2026-05-15T08:08:02.83175Z","steps":["trace[477761780] 'process raft request' (duration: 161.435846ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:03.134218Z","caller":"traceutil/trace.go:171","msg":"trace[108868438] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"295.86764ms","start":"2026-05-15T08:08:02.838317Z","end":"2026-05-15T08:08:03.134185Z","steps":["trace[108868438] 'process raft request' (duration: 295.608793ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:03.134237Z","caller":"traceutil/trace.go:171","msg":"trace[1054113957] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"296.030636ms","start":"2026-05-15T08:08:02.838164Z","end":"2026-05-15T08:08:03.134195Z","steps":["trace[1054113957] 'process raft request' (duration: 295.714566ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:03.134321Z","caller":"traceutil/trace.go:171","msg":"trace[759054843] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"275.093099ms","start":"2026-05-15T08:08:02.859212Z","end":"2026-05-15T08:08:03.134305Z","steps":["trace[759054843] 'process raft request' (duration: 274.979535ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:03.134401Z","caller":"traceutil/trace.go:171","msg":"trace[948072407] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"297.344043ms","start":"2026-05-15T08:08:02.837038Z","end":"2026-05-15T08:08:03.134382Z","steps":["trace[948072407] 'process raft request' (duration: 247.438831ms)","trace[948072407] 'compare' (duration: 49.181412ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T08:08:03.134444Z","caller":"traceutil/trace.go:171","msg":"trace[374544319] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"294.000037ms","start":"2026-05-15T08:08:02.840406Z","end":"2026-05-15T08:08:03.134406Z","steps":["trace[374544319] 'process raft request' (duration: 293.622685ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:03.134583Z","caller":"traceutil/trace.go:171","msg":"trace[1807215000] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"293.583075ms","start":"2026-05-15T08:08:02.840983Z","end":"2026-05-15T08:08:03.134566Z","steps":["trace[1807215000] 'process raft request' (duration: 293.152242ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:03.137162Z","caller":"traceutil/trace.go:171","msg":"trace[28525623] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"296.941842ms","start":"2026-05-15T08:08:02.83761Z","end":"2026-05-15T08:08:03.134551Z","steps":["trace[28525623] 'process raft request' (duration: 296.21967ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:03.176824Z","caller":"traceutil/trace.go:171","msg":"trace[1322820149] linearizableReadLoop","detail":"{readStateIndex:393; appliedIndex:384; }","duration":"238.925162ms","start":"2026-05-15T08:08:02.937877Z","end":"2026-05-15T08:08:03.176803Z","steps":["trace[1322820149] 'read index received' (duration: 146.619575ms)","trace[1322820149] 'applied index is now lower than readState.Index' (duration: 92.304307ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T08:08:03.176929Z","caller":"traceutil/trace.go:171","msg":"trace[1056283454] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"276.018309ms","start":"2026-05-15T08:08:02.9009Z","end":"2026-05-15T08:08:03.176918Z","steps":["trace[1056283454] 'process raft request' (duration: 275.563746ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:03.177109Z","caller":"traceutil/trace.go:171","msg":"trace[251984838] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"273.740633ms","start":"2026-05-15T08:08:02.903328Z","end":"2026-05-15T08:08:03.177068Z","steps":["trace[251984838] 'process raft request' (duration: 273.408884ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:03.17723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.314773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"} {"level":"info","ts":"2026-05-15T08:08:03.177295Z","caller":"traceutil/trace.go:171","msg":"trace[358308437] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:381; }","duration":"239.457168ms","start":"2026-05-15T08:08:02.937821Z","end":"2026-05-15T08:08:03.177278Z","steps":["trace[358308437] 'agreement among raft nodes before linearized reading' (duration: 239.236832ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:03.429052Z","caller":"traceutil/trace.go:171","msg":"trace[2075188161] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"241.669183ms","start":"2026-05-15T08:08:03.187341Z","end":"2026-05-15T08:08:03.42901Z","steps":["trace[2075188161] 'process raft request' (duration: 215.61881ms)","trace[2075188161] 'compare' (duration: 24.683933ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T08:08:03.429176Z","caller":"traceutil/trace.go:171","msg":"trace[916122423] linearizableReadLoop","detail":"{readStateIndex:400; appliedIndex:399; }","duration":"213.917381ms","start":"2026-05-15T08:08:03.215191Z","end":"2026-05-15T08:08:03.429108Z","steps":["trace[916122423] 'read index received' (duration: 187.783665ms)","trace[916122423] 'applied index is now lower than readState.Index' (duration: 26.128726ms)"],"step_count":2} {"level":"warn","ts":"2026-05-15T08:08:03.429695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.366054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-7c96b6546b\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-05-15T08:08:03.429789Z","caller":"traceutil/trace.go:171","msg":"trace[339197212] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-7c96b6546b; range_end:; response_count:1; response_revision:388; }","duration":"214.632082ms","start":"2026-05-15T08:08:03.215135Z","end":"2026-05-15T08:08:03.429767Z","steps":["trace[339197212] 'agreement among raft nodes before linearized reading' (duration: 214.064406ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:03.432131Z","caller":"traceutil/trace.go:171","msg":"trace[1395775550] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"216.838107ms","start":"2026-05-15T08:08:03.21527Z","end":"2026-05-15T08:08:03.432108Z","steps":["trace[1395775550] 'process raft request' (duration: 216.670662ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:03.432192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.901316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-05-15T08:08:03.432235Z","caller":"traceutil/trace.go:171","msg":"trace[1052382729] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:389; }","duration":"101.018629ms","start":"2026-05-15T08:08:03.331205Z","end":"2026-05-15T08:08:03.432224Z","steps":["trace[1052382729] 'agreement among raft nodes before linearized reading' (duration: 100.888776ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:03.606447Z","caller":"traceutil/trace.go:171","msg":"trace[331986294] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"162.955679ms","start":"2026-05-15T08:08:03.44345Z","end":"2026-05-15T08:08:03.606405Z","steps":["trace[331986294] 'process raft request' (duration: 110.589136ms)","trace[331986294] 'compare' (duration: 52.210569ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T08:08:03.606982Z","caller":"traceutil/trace.go:171","msg":"trace[1800237949] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"161.481746ms","start":"2026-05-15T08:08:03.445483Z","end":"2026-05-15T08:08:03.606965Z","steps":["trace[1800237949] 'process raft request' (duration: 161.374493ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:27.443602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.865933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-15T08:08:27.443677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:26.379846Z","time spent":"1.063824162s","remote":"127.0.0.1:50186","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-15T08:08:27.443713Z","caller":"traceutil/trace.go:171","msg":"trace[390033028] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:520; }","duration":"485.042708ms","start":"2026-05-15T08:08:26.958642Z","end":"2026-05-15T08:08:27.443684Z","steps":["trace[390033028] 'range keys from in-memory index tree' (duration: 484.596347ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:27.443709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.126941501s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-15T08:08:27.443766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:26.958614Z","time spent":"485.141081ms","remote":"127.0.0.1:60666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-15T08:08:27.443804Z","caller":"traceutil/trace.go:171","msg":"trace[17239912] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:520; }","duration":"1.127107666s","start":"2026-05-15T08:08:26.316674Z","end":"2026-05-15T08:08:27.443782Z","steps":["trace[17239912] 'range keys from in-memory index tree' (duration: 1.12683797s)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:27.443866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:26.316655Z","time spent":"1.127198989s","remote":"127.0.0.1:60372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-15T08:08:27.443959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.532206ms","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-05-15T08:08:27.443996Z","caller":"traceutil/trace.go:171","msg":"trace[161338449] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:520; }","duration":"658.618309ms","start":"2026-05-15T08:08:26.785365Z","end":"2026-05-15T08:08:27.443983Z","steps":["trace[161338449] 'range keys from in-memory index tree' (duration: 658.303899ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:27.444014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:26.785325Z","time spent":"658.684429ms","remote":"127.0.0.1:60666","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-05-15T08:08:27.444044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.152028925s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.134\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-05-15T08:08:27.443933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.153815071s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T08:08:27.444162Z","caller":"traceutil/trace.go:171","msg":"trace[1893572634] range","detail":"{range_begin:/registry/masterleases/199.19.213.134; range_end:; response_count:1; response_revision:520; }","duration":"1.152190288s","start":"2026-05-15T08:08:26.291944Z","end":"2026-05-15T08:08:27.444134Z","steps":["trace[1893572634] 'range keys from in-memory index tree' (duration: 1.151920891s)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:27.444214Z","caller":"traceutil/trace.go:171","msg":"trace[681390089] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:520; }","duration":"1.154233693s","start":"2026-05-15T08:08:26.289947Z","end":"2026-05-15T08:08:27.444181Z","steps":["trace[681390089] 'range keys from in-memory index tree' (duration: 1.153647338s)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:27.444221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:26.291936Z","time spent":"1.152272781s","remote":"127.0.0.1:60400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.19.213.134\" "} {"level":"warn","ts":"2026-05-15T08:08:27.444298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:26.289915Z","time spent":"1.154367807s","remote":"127.0.0.1:60480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"info","ts":"2026-05-15T08:08:27.649696Z","caller":"traceutil/trace.go:171","msg":"trace[209546397] linearizableReadLoop","detail":"{readStateIndex:540; appliedIndex:537; }","duration":"193.278905ms","start":"2026-05-15T08:08:27.456392Z","end":"2026-05-15T08:08:27.649671Z","steps":["trace[209546397] 'read index received' (duration: 170.539376ms)","trace[209546397] 'applied index is now lower than readState.Index' (duration: 22.737899ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T08:08:27.649701Z","caller":"traceutil/trace.go:171","msg":"trace[514614848] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"199.342094ms","start":"2026-05-15T08:08:27.450318Z","end":"2026-05-15T08:08:27.64966Z","steps":["trace[514614848] 'process raft request' (duration: 195.435401ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:27.649994Z","caller":"traceutil/trace.go:171","msg":"trace[2070655924] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"199.647323ms","start":"2026-05-15T08:08:27.450335Z","end":"2026-05-15T08:08:27.649982Z","steps":["trace[2070655924] 'process raft request' (duration: 199.265532ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:27.650331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.911472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-15T08:08:27.650339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.713853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T08:08:27.650394Z","caller":"traceutil/trace.go:171","msg":"trace[68335738] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:523; }","duration":"194.043164ms","start":"2026-05-15T08:08:27.456332Z","end":"2026-05-15T08:08:27.650375Z","steps":["trace[68335738] 'agreement among raft nodes before linearized reading' (duration: 193.886661ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:27.650419Z","caller":"traceutil/trace.go:171","msg":"trace[72625332] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:523; }","duration":"191.784865ms","start":"2026-05-15T08:08:27.458598Z","end":"2026-05-15T08:08:27.650383Z","steps":["trace[72625332] 'agreement among raft nodes before linearized reading' (duration: 191.646271ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:28.02365Z","caller":"traceutil/trace.go:171","msg":"trace[170532183] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"121.000186ms","start":"2026-05-15T08:08:27.902627Z","end":"2026-05-15T08:08:28.023627Z","steps":["trace[170532183] 'process raft request' (duration: 120.964636ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:28.023673Z","caller":"traceutil/trace.go:171","msg":"trace[921450222] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"121.127519ms","start":"2026-05-15T08:08:27.90251Z","end":"2026-05-15T08:08:28.023638Z","steps":["trace[921450222] 'process raft request' (duration: 91.595603ms)","trace[921450222] 'compare' (duration: 29.332422ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T08:08:28.12005Z","caller":"traceutil/trace.go:171","msg":"trace[67258990] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"147.032994ms","start":"2026-05-15T08:08:27.972989Z","end":"2026-05-15T08:08:28.120022Z","steps":["trace[67258990] 'process raft request' (duration: 146.958103ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:28.120569Z","caller":"traceutil/trace.go:171","msg":"trace[236721711] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"154.650025ms","start":"2026-05-15T08:08:27.965901Z","end":"2026-05-15T08:08:28.120551Z","steps":["trace[236721711] 'process raft request' (duration: 153.866175ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:28.120569Z","caller":"traceutil/trace.go:171","msg":"trace[136271752] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"154.932913ms","start":"2026-05-15T08:08:27.965551Z","end":"2026-05-15T08:08:28.120474Z","steps":["trace[136271752] 'process raft request' (duration: 154.181923ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:28.120789Z","caller":"traceutil/trace.go:171","msg":"trace[1190796504] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"154.810539ms","start":"2026-05-15T08:08:27.96596Z","end":"2026-05-15T08:08:28.120771Z","steps":["trace[1190796504] 'process raft request' (duration: 153.877265ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:28.120917Z","caller":"traceutil/trace.go:171","msg":"trace[1864916380] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"150.626419ms","start":"2026-05-15T08:08:27.970277Z","end":"2026-05-15T08:08:28.120904Z","steps":["trace[1864916380] 'process raft request' (duration: 149.623152ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:28.121088Z","caller":"traceutil/trace.go:171","msg":"trace[903362009] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"157.698775ms","start":"2026-05-15T08:08:27.963364Z","end":"2026-05-15T08:08:28.121063Z","steps":["trace[903362009] 'process raft request' (duration: 156.279618ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:28.121315Z","caller":"traceutil/trace.go:171","msg":"trace[2004470606] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"191.708622ms","start":"2026-05-15T08:08:27.929593Z","end":"2026-05-15T08:08:28.121301Z","steps":["trace[2004470606] 'process raft request' (duration: 189.874514ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:28.121689Z","caller":"traceutil/trace.go:171","msg":"trace[1894338617] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"157.729676ms","start":"2026-05-15T08:08:27.963944Z","end":"2026-05-15T08:08:28.121673Z","steps":["trace[1894338617] 'process raft request' (duration: 155.758664ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:28.224209Z","caller":"traceutil/trace.go:171","msg":"trace[124701470] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"216.777583ms","start":"2026-05-15T08:08:28.007398Z","end":"2026-05-15T08:08:28.224175Z","steps":["trace[124701470] 'process raft request' (duration: 216.499646ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:28.224413Z","caller":"traceutil/trace.go:171","msg":"trace[418510136] transaction","detail":"{read_only:false; number_of_response:0; response_revision:545; }","duration":"195.855705ms","start":"2026-05-15T08:08:28.028547Z","end":"2026-05-15T08:08:28.224402Z","steps":["trace[418510136] 'process raft request' (duration: 195.543767ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:28.224449Z","caller":"traceutil/trace.go:171","msg":"trace[542872626] linearizableReadLoop","detail":"{readStateIndex:566; appliedIndex:555; }","duration":"168.2421ms","start":"2026-05-15T08:08:28.05617Z","end":"2026-05-15T08:08:28.224412Z","steps":["trace[542872626] 'read index received' (duration: 63.229202ms)","trace[542872626] 'applied index is now lower than readState.Index' (duration: 105.011848ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T08:08:28.2246Z","caller":"traceutil/trace.go:171","msg":"trace[537246561] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"178.16885ms","start":"2026-05-15T08:08:28.046418Z","end":"2026-05-15T08:08:28.224586Z","steps":["trace[537246561] 'process raft request' (duration: 177.792341ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:28.224606Z","caller":"traceutil/trace.go:171","msg":"trace[1900214577] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"133.069895ms","start":"2026-05-15T08:08:28.091521Z","end":"2026-05-15T08:08:28.224591Z","steps":["trace[1900214577] 'process raft request' (duration: 132.813469ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:28.224873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.681841ms","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-05-15T08:08:28.224958Z","caller":"traceutil/trace.go:171","msg":"trace[1810652853] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:547; }","duration":"168.830755ms","start":"2026-05-15T08:08:28.056107Z","end":"2026-05-15T08:08:28.224938Z","steps":["trace[1810652853] 'agreement among raft nodes before linearized reading' (duration: 168.603228ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:28.242377Z","caller":"traceutil/trace.go:171","msg":"trace[24454127] transaction","detail":"{read_only:false; number_of_response:0; response_revision:547; }","duration":"115.875924ms","start":"2026-05-15T08:08:28.126481Z","end":"2026-05-15T08:08:28.242357Z","steps":["trace[24454127] 'process raft request' (duration: 115.388712ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:28.243017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.243711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-15T08:08:28.243082Z","caller":"traceutil/trace.go:171","msg":"trace[1881030155] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:550; }","duration":"181.329173ms","start":"2026-05-15T08:08:28.061745Z","end":"2026-05-15T08:08:28.243074Z","steps":["trace[1881030155] 'agreement among raft nodes before linearized reading' (duration: 181.2183ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:30.356447Z","caller":"traceutil/trace.go:171","msg":"trace[788924298] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"100.274027ms","start":"2026-05-15T08:08:30.256125Z","end":"2026-05-15T08:08:30.356399Z","steps":["trace[788924298] 'process raft request' (duration: 100.071392ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:31.650143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.053976ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-15T08:08:31.650295Z","caller":"traceutil/trace.go:171","msg":"trace[1206119935] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"221.028821ms","start":"2026-05-15T08:08:31.429243Z","end":"2026-05-15T08:08:31.650272Z","steps":["trace[1206119935] 'process raft request' (duration: 68.767019ms)","trace[1206119935] 'compare' (duration: 151.548173ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T08:08:31.652302Z","caller":"traceutil/trace.go:171","msg":"trace[1823193294] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:627; }","duration":"196.82304ms","start":"2026-05-15T08:08:31.455449Z","end":"2026-05-15T08:08:31.652272Z","steps":["trace[1823193294] 'read index received' (duration: 42.574927ms)","trace[1823193294] 'applied index is now lower than readState.Index' (duration: 154.246583ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T08:08:31.652386Z","caller":"traceutil/trace.go:171","msg":"trace[1784687409] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"222.998822ms","start":"2026-05-15T08:08:31.429337Z","end":"2026-05-15T08:08:31.652336Z","steps":["trace[1784687409] 'process raft request' (duration: 222.757355ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:31.652503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.035726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-15T08:08:31.652549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.936883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T08:08:31.652584Z","caller":"traceutil/trace.go:171","msg":"trace[859894209] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:608; }","duration":"197.16473ms","start":"2026-05-15T08:08:31.455404Z","end":"2026-05-15T08:08:31.652569Z","steps":["trace[859894209] 'agreement among raft nodes before linearized reading' (duration: 197.002685ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:31.6526Z","caller":"traceutil/trace.go:171","msg":"trace[1009298096] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:608; }","duration":"197.071447ms","start":"2026-05-15T08:08:31.455512Z","end":"2026-05-15T08:08:31.652584Z","steps":["trace[1009298096] 'agreement among raft nodes before linearized reading' (duration: 196.950424ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:31.652765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.825304ms","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-05-15T08:08:31.652839Z","caller":"traceutil/trace.go:171","msg":"trace[654273672] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:608; }","duration":"135.935536ms","start":"2026-05-15T08:08:31.516884Z","end":"2026-05-15T08:08:31.65282Z","steps":["trace[654273672] 'agreement among raft nodes before linearized reading' (duration: 135.792253ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:31.652856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.527946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-15T08:08:31.652888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.294253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T08:08:31.652907Z","caller":"traceutil/trace.go:171","msg":"trace[1455041663] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:608; }","duration":"175.577747ms","start":"2026-05-15T08:08:31.477319Z","end":"2026-05-15T08:08:31.652897Z","steps":["trace[1455041663] 'agreement among raft nodes before linearized reading' (duration: 175.513925ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:31.652927Z","caller":"traceutil/trace.go:171","msg":"trace[980084488] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:608; }","duration":"197.378005ms","start":"2026-05-15T08:08:31.455534Z","end":"2026-05-15T08:08:31.652912Z","steps":["trace[980084488] 'agreement among raft nodes before linearized reading' (duration: 197.314553ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:31.653167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.290136ms","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-05-15T08:08:31.653233Z","caller":"traceutil/trace.go:171","msg":"trace[2100931763] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:608; }","duration":"136.400289ms","start":"2026-05-15T08:08:31.516818Z","end":"2026-05-15T08:08:31.653218Z","steps":["trace[2100931763] 'agreement among raft nodes before linearized reading' (duration: 136.308266ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:31.653252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.883369ms","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-05-15T08:08:31.653302Z","caller":"traceutil/trace.go:171","msg":"trace[765221131] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:608; }","duration":"104.990591ms","start":"2026-05-15T08:08:31.5483Z","end":"2026-05-15T08:08:31.653291Z","steps":["trace[765221131] 'agreement among raft nodes before linearized reading' (duration: 104.915429ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:31.653366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.993808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T08:08:31.653418Z","caller":"traceutil/trace.go:171","msg":"trace[403610260] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:608; }","duration":"176.075181ms","start":"2026-05-15T08:08:31.477326Z","end":"2026-05-15T08:08:31.653402Z","steps":["trace[403610260] 'agreement among raft nodes before linearized reading' (duration: 176.004459ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:31.653497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.217197ms","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-05-15T08:08:31.653539Z","caller":"traceutil/trace.go:171","msg":"trace[1144751785] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:608; }","duration":"105.29764ms","start":"2026-05-15T08:08:31.548231Z","end":"2026-05-15T08:08:31.653529Z","steps":["trace[1144751785] 'agreement among raft nodes before linearized reading' (duration: 105.235728ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:31.653588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.908126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T08:08:31.653629Z","caller":"traceutil/trace.go:171","msg":"trace[64897183] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:608; }","duration":"175.960267ms","start":"2026-05-15T08:08:31.477658Z","end":"2026-05-15T08:08:31.653618Z","steps":["trace[64897183] 'agreement among raft nodes before linearized reading' (duration: 175.895905ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:31.652795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.961805ms","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-05-15T08:08:31.65367Z","caller":"traceutil/trace.go:171","msg":"trace[1964307856] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:608; }","duration":"104.850628ms","start":"2026-05-15T08:08:31.548808Z","end":"2026-05-15T08:08:31.653659Z","steps":["trace[1964307856] 'agreement among raft nodes before linearized reading' (duration: 103.958325ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:34.201118Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9726541726372756036,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-15T08:08:34.208269Z","caller":"traceutil/trace.go:171","msg":"trace[2105492961] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:639; }","duration":"508.252225ms","start":"2026-05-15T08:08:33.699988Z","end":"2026-05-15T08:08:34.20824Z","steps":["trace[2105492961] 'read index received' (duration: 507.083395ms)","trace[2105492961] 'applied index is now lower than readState.Index' (duration: 1.16795ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T08:08:34.208429Z","caller":"traceutil/trace.go:171","msg":"trace[1269335193] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"710.515234ms","start":"2026-05-15T08:08:33.497864Z","end":"2026-05-15T08:08:34.208379Z","steps":["trace[1269335193] 'process raft request' (duration: 709.57105ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:34.208529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.516721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-15T08:08:34.208586Z","caller":"traceutil/trace.go:171","msg":"trace[193071205] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:618; }","duration":"508.639255ms","start":"2026-05-15T08:08:33.699929Z","end":"2026-05-15T08:08:34.208569Z","steps":["trace[193071205] 'agreement among raft nodes before linearized reading' (duration: 508.455019ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:34.208641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:33.699907Z","time spent":"508.721947ms","remote":"127.0.0.1:60666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-15T08:08:34.208707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:33.497822Z","time spent":"710.717609ms","remote":"127.0.0.1:60480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036193,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-15T08:08:34.208984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.453591ms","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-05-15T08:08:34.209025Z","caller":"traceutil/trace.go:171","msg":"trace[31007772] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:618; }","duration":"481.525973ms","start":"2026-05-15T08:08:33.72749Z","end":"2026-05-15T08:08:34.209016Z","steps":["trace[31007772] 'agreement among raft nodes before linearized reading' (duration: 481.42164ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:34.209054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:33.72747Z","time spent":"481.576445ms","remote":"127.0.0.1:60666","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-05-15T08:08:34.498639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.688026ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-15T08:08:34.498833Z","caller":"traceutil/trace.go:171","msg":"trace[1800613409] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:640; }","duration":"181.741435ms","start":"2026-05-15T08:08:34.317077Z","end":"2026-05-15T08:08:34.498819Z","steps":["trace[1800613409] 'read index received' (duration: 80.755861ms)","trace[1800613409] 'applied index is now lower than readState.Index' (duration: 100.984804ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T08:08:34.498849Z","caller":"traceutil/trace.go:171","msg":"trace[573751753] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"284.962285ms","start":"2026-05-15T08:08:34.213861Z","end":"2026-05-15T08:08:34.498824Z","steps":["trace[573751753] 'process raft request' (duration: 184.007442ms)","trace[573751753] 'compare' (duration: 100.546132ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T08:08:34.498972Z","caller":"traceutil/trace.go:171","msg":"trace[982417995] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"284.533324ms","start":"2026-05-15T08:08:34.214431Z","end":"2026-05-15T08:08:34.498964Z","steps":["trace[982417995] 'process raft request' (duration: 284.305538ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:34.499112Z","caller":"traceutil/trace.go:171","msg":"trace[801418197] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"204.145191ms","start":"2026-05-15T08:08:34.294962Z","end":"2026-05-15T08:08:34.499107Z","steps":["trace[801418197] 'process raft request' (duration: 203.808043ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:34.499194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.116804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T08:08:34.499263Z","caller":"traceutil/trace.go:171","msg":"trace[1607941484] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:621; }","duration":"182.222517ms","start":"2026-05-15T08:08:34.317035Z","end":"2026-05-15T08:08:34.499257Z","steps":["trace[1607941484] 'agreement among raft nodes before linearized reading' (duration: 182.138414ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:34.499474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.083848ms","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-05-15T08:08:34.499538Z","caller":"traceutil/trace.go:171","msg":"trace[1508583195] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:621; }","duration":"110.20503ms","start":"2026-05-15T08:08:34.389313Z","end":"2026-05-15T08:08:34.499518Z","steps":["trace[1508583195] 'agreement among raft nodes before linearized reading' (duration: 109.991135ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:36.440261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.552789ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-15T08:08:36.440383Z","caller":"traceutil/trace.go:171","msg":"trace[5781899] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"372.68177ms","start":"2026-05-15T08:08:36.067681Z","end":"2026-05-15T08:08:36.440363Z","steps":["trace[5781899] 'read index received' (duration: 203.830823ms)","trace[5781899] 'applied index is now lower than readState.Index' (duration: 168.849347ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T08:08:36.440494Z","caller":"traceutil/trace.go:171","msg":"trace[128475421] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"377.864503ms","start":"2026-05-15T08:08:36.062615Z","end":"2026-05-15T08:08:36.44048Z","steps":["trace[128475421] 'process raft request' (duration: 208.984996ms)","trace[128475421] 'compare' (duration: 168.401565ms)"],"step_count":2} {"level":"warn","ts":"2026-05-15T08:08:36.440608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:36.062589Z","time spent":"377.963255ms","remote":"127.0.0.1:60582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-15T08:08:36.440819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.140911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T08:08:36.440879Z","caller":"traceutil/trace.go:171","msg":"trace[667854988] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:634; }","duration":"373.218713ms","start":"2026-05-15T08:08:36.067646Z","end":"2026-05-15T08:08:36.440865Z","steps":["trace[667854988] 'agreement among raft nodes before linearized reading' (duration: 373.125001ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:36.440914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:36.067628Z","time spent":"373.277845ms","remote":"127.0.0.1:60638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-05-15T08:08:36.440994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.485184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.134\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-15T08:08:36.441089Z","caller":"traceutil/trace.go:171","msg":"trace[500460254] range","detail":"{range_begin:/registry/masterleases/199.19.213.134; range_end:; response_count:1; response_revision:634; }","duration":"148.652188ms","start":"2026-05-15T08:08:36.292411Z","end":"2026-05-15T08:08:36.441063Z","steps":["trace[500460254] 'agreement among raft nodes before linearized reading' (duration: 148.423973ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:36.441107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.075271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T08:08:36.441199Z","caller":"traceutil/trace.go:171","msg":"trace[1070275508] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:634; }","duration":"124.178543ms","start":"2026-05-15T08:08:36.316995Z","end":"2026-05-15T08:08:36.441174Z","steps":["trace[1070275508] 'agreement among raft nodes before linearized reading' (duration: 124.037259ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:36.943857Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9726541726372756067,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-15T08:08:37.203402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:36.442588Z","time spent":"760.80379ms","remote":"127.0.0.1:60400","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-15T08:08:37.272344Z","caller":"traceutil/trace.go:171","msg":"trace[1929198214] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:656; }","duration":"829.222348ms","start":"2026-05-15T08:08:36.44303Z","end":"2026-05-15T08:08:37.272252Z","steps":["trace[1929198214] 'read index received' (duration: 678.864135ms)","trace[1929198214] 'applied index is now lower than readState.Index' (duration: 150.355572ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T08:08:37.275565Z","caller":"traceutil/trace.go:171","msg":"trace[1573120672] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"422.545478ms","start":"2026-05-15T08:08:36.852942Z","end":"2026-05-15T08:08:37.275488Z","steps":["trace[1573120672] 'process raft request' (duration: 416.192586ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:37.275778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:36.852917Z","time spent":"422.737102ms","remote":"127.0.0.1:60480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-15T08:08:37.275839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"832.790848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T08:08:37.276443Z","caller":"traceutil/trace.go:171","msg":"trace[572249853] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"833.453936ms","start":"2026-05-15T08:08:36.442962Z","end":"2026-05-15T08:08:37.276416Z","steps":["trace[572249853] 'agreement among raft nodes before linearized reading' (duration: 832.518772ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:37.276479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:36.442941Z","time spent":"833.527418ms","remote":"127.0.0.1:60358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-15T08:08:37.286137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"781.448583ms","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-05-15T08:08:37.286271Z","caller":"traceutil/trace.go:171","msg":"trace[1776990640] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:636; }","duration":"781.654479ms","start":"2026-05-15T08:08:36.504601Z","end":"2026-05-15T08:08:37.286256Z","steps":["trace[1776990640] 'agreement among raft nodes before linearized reading' (duration: 781.354261ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:37.28633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:36.504573Z","time spent":"781.74927ms","remote":"127.0.0.1:60666","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-05-15T08:08:37.286683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"777.266485ms","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-05-15T08:08:37.286742Z","caller":"traceutil/trace.go:171","msg":"trace[2010222043] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:636; }","duration":"777.331447ms","start":"2026-05-15T08:08:36.509402Z","end":"2026-05-15T08:08:37.286733Z","steps":["trace[2010222043] 'agreement among raft nodes before linearized reading' (duration: 777.229594ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:37.286781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:36.509394Z","time spent":"777.381418ms","remote":"127.0.0.1:60666","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-05-15T08:08:37.286967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"777.693006ms","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-05-15T08:08:37.287024Z","caller":"traceutil/trace.go:171","msg":"trace[706344127] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:636; }","duration":"777.771579ms","start":"2026-05-15T08:08:36.509244Z","end":"2026-05-15T08:08:37.287015Z","steps":["trace[706344127] 'agreement among raft nodes before linearized reading' (duration: 777.671076ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:37.287066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:36.509239Z","time spent":"777.820409ms","remote":"127.0.0.1:60666","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-05-15T08:08:37.287229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"780.829227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-15T08:08:37.287286Z","caller":"traceutil/trace.go:171","msg":"trace[1489102326] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:636; }","duration":"780.886658ms","start":"2026-05-15T08:08:36.506392Z","end":"2026-05-15T08:08:37.287279Z","steps":["trace[1489102326] 'agreement among raft nodes before linearized reading' (duration: 780.776385ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:37.287324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:36.506326Z","time spent":"780.991621ms","remote":"127.0.0.1:60666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-15T08:08:38.707753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.363115378s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-15T08:08:38.707876Z","caller":"traceutil/trace.go:171","msg":"trace[152805272] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"1.414801928s","start":"2026-05-15T08:08:37.293055Z","end":"2026-05-15T08:08:38.707857Z","steps":["trace[152805272] 'process raft request' (duration: 51.456084ms)","trace[152805272] 'compare' (duration: 1.362550593s)"],"step_count":2} {"level":"warn","ts":"2026-05-15T08:08:38.707933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:37.293039Z","time spent":"1.414866519s","remote":"127.0.0.1:60666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-15T08:08:39.465993Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.111111669s","expected-duration":"1s"} {"level":"info","ts":"2026-05-15T08:08:39.520476Z","caller":"traceutil/trace.go:171","msg":"trace[291051437] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"2.227266698s","start":"2026-05-15T08:08:37.293168Z","end":"2026-05-15T08:08:39.520435Z","steps":["trace[291051437] 'process raft request' (duration: 2.173156194s)","trace[291051437] 'compare' (duration: 53.55838ms)"],"step_count":2} {"level":"warn","ts":"2026-05-15T08:08:39.520699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:37.29314Z","time spent":"2.227440924s","remote":"127.0.0.1:60666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-15T08:08:39.520713Z","caller":"traceutil/trace.go:171","msg":"trace[1603129117] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"2.226675924s","start":"2026-05-15T08:08:37.293936Z","end":"2026-05-15T08:08:39.520611Z","steps":["trace[1603129117] 'process raft request' (duration: 2.226420387s)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:39.520812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:37.293919Z","time spent":"2.226834867s","remote":"127.0.0.1:60666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-15T08:08:39.521128Z","caller":"traceutil/trace.go:171","msg":"trace[1713692244] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"602.591664ms","start":"2026-05-15T08:08:38.918521Z","end":"2026-05-15T08:08:39.521113Z","steps":["trace[1713692244] 'process raft request' (duration: 602.539773ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:39.521113Z","caller":"traceutil/trace.go:171","msg":"trace[1139622116] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"2.226770606s","start":"2026-05-15T08:08:37.294277Z","end":"2026-05-15T08:08:39.521048Z","steps":["trace[1139622116] 'process raft request' (duration: 2.226275773s)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:39.521171Z","caller":"traceutil/trace.go:171","msg":"trace[95207077] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:659; }","duration":"2.226667824s","start":"2026-05-15T08:08:37.294488Z","end":"2026-05-15T08:08:39.521156Z","steps":["trace[95207077] 'read index received' (duration: 50.034649ms)","trace[95207077] 'applied index is now lower than readState.Index' (duration: 2.176631855s)"],"step_count":2} {"level":"warn","ts":"2026-05-15T08:08:39.521296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:38.918479Z","time spent":"602.721218ms","remote":"127.0.0.1:60666","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-05-15T08:08:39.521128Z","caller":"traceutil/trace.go:171","msg":"trace[1809583006] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"2.183588523s","start":"2026-05-15T08:08:37.337509Z","end":"2026-05-15T08:08:39.521098Z","steps":["trace[1809583006] 'process raft request' (duration: 2.18346261s)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:39.521344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:37.294251Z","time spent":"2.226970381s","remote":"127.0.0.1:60666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-15T08:08:39.521343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.226844438s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-05-15T08:08:39.521378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.204328369s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T08:08:39.521395Z","caller":"traceutil/trace.go:171","msg":"trace[708130870] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:642; }","duration":"2.226922869s","start":"2026-05-15T08:08:37.294456Z","end":"2026-05-15T08:08:39.521379Z","steps":["trace[708130870] 'agreement among raft nodes before linearized reading' (duration: 2.226792466s)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:39.521423Z","caller":"traceutil/trace.go:171","msg":"trace[1659142329] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:642; }","duration":"1.204411281s","start":"2026-05-15T08:08:38.316997Z","end":"2026-05-15T08:08:39.521409Z","steps":["trace[1659142329] 'agreement among raft nodes before linearized reading' (duration: 1.204341929s)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:39.521413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:37.337485Z","time spent":"2.18386179s","remote":"127.0.0.1:60638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-15T08:08:39.521439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:37.294448Z","time spent":"2.2269802s","remote":"127.0.0.1:60674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"warn","ts":"2026-05-15T08:08:39.521455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:38.316974Z","time spent":"1.204475903s","remote":"127.0.0.1:60372","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-05-15T08:08:41.595504Z","caller":"traceutil/trace.go:171","msg":"trace[128156748] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"100.046427ms","start":"2026-05-15T08:08:41.495415Z","end":"2026-05-15T08:08:41.595461Z","steps":["trace[128156748] 'process raft request' (duration: 99.714859ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:08:52.47804Z","caller":"traceutil/trace.go:171","msg":"trace[1209314938] linearizableReadLoop","detail":"{readStateIndex:812; appliedIndex:811; }","duration":"161.189608ms","start":"2026-05-15T08:08:52.316817Z","end":"2026-05-15T08:08:52.478006Z","steps":["trace[1209314938] 'read index received' (duration: 156.372179ms)","trace[1209314938] 'applied index is now lower than readState.Index' (duration: 4.815599ms)"],"step_count":2} {"level":"warn","ts":"2026-05-15T08:08:52.478201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.368021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T08:08:52.478237Z","caller":"traceutil/trace.go:171","msg":"trace[1148867711] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:785; }","duration":"161.430873ms","start":"2026-05-15T08:08:52.316794Z","end":"2026-05-15T08:08:52.478225Z","steps":["trace[1148867711] 'agreement among raft nodes before linearized reading' (duration: 161.337481ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:55.695927Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9726541726372756387,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-15T08:08:56.191209Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.036264174s","expected-duration":"1s"} {"level":"info","ts":"2026-05-15T08:08:56.191708Z","caller":"traceutil/trace.go:171","msg":"trace[2037767518] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"1.03692939s","start":"2026-05-15T08:08:55.154748Z","end":"2026-05-15T08:08:56.191677Z","steps":["trace[2037767518] 'process raft request' (duration: 1.036732455s)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:56.191932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:55.154718Z","time spent":"1.037095013s","remote":"127.0.0.1:60582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-15T08:08:56.195791Z","caller":"traceutil/trace.go:171","msg":"trace[743222573] linearizableReadLoop","detail":"{readStateIndex:829; appliedIndex:827; }","duration":"1.000667014s","start":"2026-05-15T08:08:55.195106Z","end":"2026-05-15T08:08:56.195773Z","steps":["trace[743222573] 'read index received' (duration: 996.37957ms)","trace[743222573] 'applied index is now lower than readState.Index' (duration: 4.286634ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T08:08:56.196019Z","caller":"traceutil/trace.go:171","msg":"trace[1402113930] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"853.704212ms","start":"2026-05-15T08:08:55.342304Z","end":"2026-05-15T08:08:56.196009Z","steps":["trace[1402113930] 'process raft request' (duration: 853.374034ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:56.196085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:55.342278Z","time spent":"853.764744ms","remote":"127.0.0.1:60666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-15T08:08:56.196316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.001210718s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-15T08:08:56.196347Z","caller":"traceutil/trace.go:171","msg":"trace[339204687] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:801; }","duration":"1.001291851s","start":"2026-05-15T08:08:55.195048Z","end":"2026-05-15T08:08:56.19634Z","steps":["trace[339204687] 'agreement among raft nodes before linearized reading' (duration: 1.001173327s)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:56.196393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:55.195025Z","time spent":"1.001361571s","remote":"127.0.0.1:60666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-15T08:08:56.19651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.393737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T08:08:56.196532Z","caller":"traceutil/trace.go:171","msg":"trace[296777435] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:801; }","duration":"881.462509ms","start":"2026-05-15T08:08:55.315063Z","end":"2026-05-15T08:08:56.196525Z","steps":["trace[296777435] 'agreement among raft nodes before linearized reading' (duration: 881.428478ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:56.196548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:55.315038Z","time spent":"881.50623ms","remote":"127.0.0.1:60372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-15T08:08:56.196719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.39474ms","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-05-15T08:08:56.196741Z","caller":"traceutil/trace.go:171","msg":"trace[1221558175] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:801; }","duration":"498.460161ms","start":"2026-05-15T08:08:55.698275Z","end":"2026-05-15T08:08:56.196735Z","steps":["trace[1221558175] 'agreement among raft nodes before linearized reading' (duration: 498.39819ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:56.196758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:55.698251Z","time spent":"498.503063ms","remote":"127.0.0.1:60666","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-05-15T08:08:56.196872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.917645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-15T08:08:56.196893Z","caller":"traceutil/trace.go:171","msg":"trace[1369854730] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:801; }","duration":"501.965957ms","start":"2026-05-15T08:08:55.694922Z","end":"2026-05-15T08:08:56.196888Z","steps":["trace[1369854730] 'agreement among raft nodes before linearized reading' (duration: 501.908535ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:56.196909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:55.694907Z","time spent":"501.998858ms","remote":"127.0.0.1:60666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-15T08:08:56.197019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.460201ms","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-05-15T08:08:56.197039Z","caller":"traceutil/trace.go:171","msg":"trace[1014324617] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:801; }","duration":"507.541573ms","start":"2026-05-15T08:08:55.689492Z","end":"2026-05-15T08:08:56.197034Z","steps":["trace[1014324617] 'agreement among raft nodes before linearized reading' (duration: 507.487851ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:08:56.197056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:08:55.689458Z","time spent":"507.594033ms","remote":"127.0.0.1:60666","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-05-15T08:09:01.937492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.17033ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-15T08:09:02.434974Z","caller":"traceutil/trace.go:171","msg":"trace[727577913] transaction","detail":"{read_only:false; response_revision:867; number_of_response:1; }","duration":"196.356804ms","start":"2026-05-15T08:09:02.238584Z","end":"2026-05-15T08:09:02.434941Z","steps":["trace[727577913] 'process raft request' (duration: 195.643417ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:09:02.435227Z","caller":"traceutil/trace.go:171","msg":"trace[195678016] linearizableReadLoop","detail":"{readStateIndex:897; appliedIndex:895; }","duration":"196.091638ms","start":"2026-05-15T08:09:02.239102Z","end":"2026-05-15T08:09:02.435194Z","steps":["trace[195678016] 'read index received' (duration: 40.262696ms)","trace[195678016] 'applied index is now lower than readState.Index' (duration: 155.826592ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T08:09:02.435281Z","caller":"traceutil/trace.go:171","msg":"trace[439707194] transaction","detail":"{read_only:false; response_revision:868; number_of_response:1; }","duration":"193.794913ms","start":"2026-05-15T08:09:02.241468Z","end":"2026-05-15T08:09:02.435262Z","steps":["trace[439707194] 'process raft request' (duration: 193.424124ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:09:02.435525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.176017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T08:09:02.435631Z","caller":"traceutil/trace.go:171","msg":"trace[995594956] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:868; }","duration":"118.31246ms","start":"2026-05-15T08:09:02.317296Z","end":"2026-05-15T08:09:02.435609Z","steps":["trace[995594956] 'agreement among raft nodes before linearized reading' (duration: 118.170507ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:09:02.435567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.431656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-15T08:09:02.435855Z","caller":"traceutil/trace.go:171","msg":"trace[874724232] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:868; }","duration":"196.733063ms","start":"2026-05-15T08:09:02.239096Z","end":"2026-05-15T08:09:02.435829Z","steps":["trace[874724232] 'agreement among raft nodes before linearized reading' (duration: 196.275832ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:09:58.90831Z","caller":"traceutil/trace.go:171","msg":"trace[716432383] transaction","detail":"{read_only:false; response_revision:1140; number_of_response:1; }","duration":"115.58743ms","start":"2026-05-15T08:09:58.792688Z","end":"2026-05-15T08:09:58.908276Z","steps":["trace[716432383] 'process raft request' (duration: 109.958134ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:10:36.442173Z","caller":"traceutil/trace.go:171","msg":"trace[1688775000] linearizableReadLoop","detail":"{readStateIndex:1312; appliedIndex:1311; }","duration":"114.696471ms","start":"2026-05-15T08:10:36.327438Z","end":"2026-05-15T08:10:36.442135Z","steps":["trace[1688775000] 'read index received' (duration: 38.843747ms)","trace[1688775000] 'applied index is now lower than readState.Index' (duration: 75.851424ms)"],"step_count":2} {"level":"info","ts":"2026-05-15T08:10:36.44223Z","caller":"traceutil/trace.go:171","msg":"trace[1168781120] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"114.847275ms","start":"2026-05-15T08:10:36.327329Z","end":"2026-05-15T08:10:36.442177Z","steps":["trace[1168781120] 'process raft request' (duration: 38.889888ms)","trace[1168781120] 'compare' (duration: 75.714162ms)"],"step_count":2} {"level":"warn","ts":"2026-05-15T08:10:36.442458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.999978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-15T08:10:36.442547Z","caller":"traceutil/trace.go:171","msg":"trace[797745979] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1262; }","duration":"115.148172ms","start":"2026-05-15T08:10:36.327377Z","end":"2026-05-15T08:10:36.442525Z","steps":["trace[797745979] 'agreement among raft nodes before linearized reading' (duration: 114.904046ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:10:51.135709Z","caller":"traceutil/trace.go:171","msg":"trace[921210455] transaction","detail":"{read_only:false; response_revision:1342; number_of_response:1; }","duration":"147.935305ms","start":"2026-05-15T08:10:50.987729Z","end":"2026-05-15T08:10:51.135664Z","steps":["trace[921210455] 'process raft request' (duration: 147.624788ms)"],"step_count":1} {"level":"info","ts":"2026-05-15T08:10:59.574514Z","caller":"traceutil/trace.go:171","msg":"trace[162333092] transaction","detail":"{read_only:false; response_revision:1376; number_of_response:1; }","duration":"387.986723ms","start":"2026-05-15T08:10:59.186471Z","end":"2026-05-15T08:10:59.574458Z","steps":["trace[162333092] 'process raft request' (duration: 366.870313ms)","trace[162333092] 'compare' (duration: 20.858115ms)"],"step_count":2} {"level":"warn","ts":"2026-05-15T08:10:59.574747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:10:59.186446Z","time spent":"388.187577ms","remote":"127.0.0.1:60666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-15T08:10:59.574741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.910183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-15T08:10:59.574994Z","caller":"traceutil/trace.go:171","msg":"trace[479677951] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1376; }","duration":"329.1598ms","start":"2026-05-15T08:10:59.245773Z","end":"2026-05-15T08:10:59.5749Z","steps":["trace[479677951] 'agreement among raft nodes before linearized reading' (duration: 328.849393ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:10:59.575084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:10:59.245752Z","time spent":"329.315553ms","remote":"127.0.0.1:60666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-15T08:10:59.574584Z","caller":"traceutil/trace.go:171","msg":"trace[1209059950] linearizableReadLoop","detail":"{readStateIndex:1431; appliedIndex:1430; }","duration":"328.547336ms","start":"2026-05-15T08:10:59.245808Z","end":"2026-05-15T08:10:59.574355Z","steps":["trace[1209059950] 'read index received' (duration: 307.454626ms)","trace[1209059950] 'applied index is now lower than readState.Index' (duration: 21.091629ms)"],"step_count":2} {"level":"warn","ts":"2026-05-15T08:10:59.576871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.128293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-15T08:10:59.576904Z","caller":"traceutil/trace.go:171","msg":"trace[1268897395] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1376; }","duration":"318.186375ms","start":"2026-05-15T08:10:59.258709Z","end":"2026-05-15T08:10:59.576895Z","steps":["trace[1268897395] 'agreement among raft nodes before linearized reading' (duration: 318.082102ms)"],"step_count":1} {"level":"warn","ts":"2026-05-15T08:10:59.576925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-15T08:10:59.258696Z","time spent":"318.224266ms","remote":"127.0.0.1:60666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}