{"level":"warn","ts":"2026-06-15T19:53:56.663373Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-15T19:53:56.663486Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.25:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.25:2380","--initial-cluster=instance=https://199.204.45.25:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.25:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.25: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-06-15T19:53:56.663575Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-15T19:53:56.663593Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-06-15T19:53:56.663619Z","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-06-15T19:53:56.664605Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"]} {"level":"info","ts":"2026-06-15T19:53:56.664718Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.25: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-06-15T19:53:56.669155Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.057862ms"} {"level":"info","ts":"2026-06-15T19:53:56.677932Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ba52c55cf4193752","cluster-id":"4468ed52294bc271"} {"level":"info","ts":"2026-06-15T19:53:56.678038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=()"} {"level":"info","ts":"2026-06-15T19:53:56.678071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 0"} {"level":"info","ts":"2026-06-15T19:53:56.678086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ba52c55cf4193752 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-15T19:53:56.678102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 1"} {"level":"info","ts":"2026-06-15T19:53:56.678151Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"warn","ts":"2026-06-15T19:53:56.682876Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-15T19:53:56.684322Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-15T19:53:56.685728Z","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-06-15T19:53:56.687967Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ba52c55cf4193752","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-15T19:53:56.690708Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ba52c55cf4193752","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-15T19:53:56.692055Z","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-06-15T19:53:56.692196Z","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-06-15T19:53:56.692212Z","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-06-15T19:53:56.694127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"info","ts":"2026-06-15T19:53:56.694245Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","added-peer-id":"ba52c55cf4193752","added-peer-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-06-15T19:53:56.694661Z","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-06-15T19:53:56.694831Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-06-15T19:53:56.694873Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-06-15T19:53:56.695134Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ba52c55cf4193752","initial-advertise-peer-urls":["https://199.204.45.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-15T19:53:56.69519Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-15T19:53:57.083964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 is starting a new election at term 1"} {"level":"info","ts":"2026-06-15T19:53:57.084025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-15T19:53:57.08405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgPreVoteResp from ba52c55cf4193752 at term 1"} {"level":"info","ts":"2026-06-15T19:53:57.084068Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became candidate at term 2"} {"level":"info","ts":"2026-06-15T19:53:57.08408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgVoteResp from ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-06-15T19:53:57.084112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became leader at term 2"} {"level":"info","ts":"2026-06-15T19:53:57.084126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ba52c55cf4193752 elected leader ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-06-15T19:53:57.086236Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T19:53:57.088482Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ba52c55cf4193752","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.25:2379]}","request-path":"/0/members/ba52c55cf4193752/attributes","cluster-id":"4468ed52294bc271","publish-timeout":"7s"} {"level":"info","ts":"2026-06-15T19:53:57.088596Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T19:53:57.092661Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T19:53:57.092738Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T19:53:57.092766Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T19:53:57.093262Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-15T19:53:57.093583Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T19:53:57.098118Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.25:2379"} {"level":"info","ts":"2026-06-15T19:53:57.098459Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-15T19:53:57.09852Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-15T19:54:00.633524Z","caller":"traceutil/trace.go:171","msg":"trace[977581725] transaction","detail":"{read_only:false; response_revision:183; number_of_response:1; }","duration":"340.947275ms","start":"2026-06-15T19:54:00.292557Z","end":"2026-06-15T19:54:00.633505Z","steps":["trace[977581725] 'process raft request' (duration: 331.628573ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:00.634114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:00.292549Z","time spent":"341.084086ms","remote":"127.0.0.1:44514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":748,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-15T19:54:04.274539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.794929ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:54:04.274815Z","caller":"traceutil/trace.go:171","msg":"trace[1255631396] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"387.873627ms","start":"2026-06-15T19:54:03.886925Z","end":"2026-06-15T19:54:04.274799Z","steps":["trace[1255631396] 'process raft request' (duration: 387.764926ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:04.274887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:03.886909Z","time spent":"387.951638ms","remote":"127.0.0.1:44380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:54:04.275257Z","caller":"traceutil/trace.go:171","msg":"trace[1092382390] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"393.181038ms","start":"2026-06-15T19:54:03.882015Z","end":"2026-06-15T19:54:04.275196Z","steps":["trace[1092382390] 'process raft request' (duration: 268.407652ms)","trace[1092382390] 'compare' (duration: 123.671228ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:54:04.275513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:03.881993Z","time spent":"393.393559ms","remote":"127.0.0.1:44372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7279,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:54:07.409113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.374081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-06-15T19:54:07.409198Z","caller":"traceutil/trace.go:171","msg":"trace[960206196] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:353; }","duration":"173.531142ms","start":"2026-06-15T19:54:07.235648Z","end":"2026-06-15T19:54:07.409179Z","steps":["trace[960206196] 'range keys from in-memory index tree' (duration: 173.219601ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:07.452109Z","caller":"traceutil/trace.go:171","msg":"trace[324631506] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"195.229316ms","start":"2026-06-15T19:54:07.256805Z","end":"2026-06-15T19:54:07.452035Z","steps":["trace[324631506] 'process raft request' (duration: 194.979724ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:07.481694Z","caller":"traceutil/trace.go:171","msg":"trace[546269731] linearizableReadLoop","detail":"{readStateIndex:370; appliedIndex:368; }","duration":"191.945753ms","start":"2026-06-15T19:54:07.289688Z","end":"2026-06-15T19:54:07.481634Z","steps":["trace[546269731] 'read index received' (duration: 161.130419ms)","trace[546269731] 'applied index is now lower than readState.Index' (duration: 30.814364ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:54:07.481806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.112184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-06-15T19:54:07.482208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.175029ms","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-06-15T19:54:07.482255Z","caller":"traceutil/trace.go:171","msg":"trace[769531915] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:355; }","duration":"157.28902ms","start":"2026-06-15T19:54:07.324953Z","end":"2026-06-15T19:54:07.482242Z","steps":["trace[769531915] 'agreement among raft nodes before linearized reading' (duration: 157.174569ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:07.482233Z","caller":"traceutil/trace.go:171","msg":"trace[451921489] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:355; }","duration":"192.575257ms","start":"2026-06-15T19:54:07.289634Z","end":"2026-06-15T19:54:07.482209Z","steps":["trace[451921489] 'agreement among raft nodes before linearized reading' (duration: 192.107303ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:07.481712Z","caller":"traceutil/trace.go:171","msg":"trace[2026419486] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"223.196439ms","start":"2026-06-15T19:54:07.258491Z","end":"2026-06-15T19:54:07.481687Z","steps":["trace[2026419486] 'process raft request' (duration: 223.019828ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:07.48259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.4748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-06-15T19:54:07.482621Z","caller":"traceutil/trace.go:171","msg":"trace[541722174] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:355; }","duration":"145.522752ms","start":"2026-06-15T19:54:07.33709Z","end":"2026-06-15T19:54:07.482613Z","steps":["trace[541722174] 'agreement among raft nodes before linearized reading' (duration: 145.478831ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:09.251972Z","caller":"traceutil/trace.go:171","msg":"trace[1482629857] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"318.677832ms","start":"2026-06-15T19:54:08.933275Z","end":"2026-06-15T19:54:09.251953Z","steps":["trace[1482629857] 'process raft request' (duration: 239.059015ms)","trace[1482629857] 'compare' (duration: 79.539817ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:54:09.252086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:08.933265Z","time spent":"318.759523ms","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:54:10.887175Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986423222828190077,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-15T19:54:10.937256Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.342367009s","expected-duration":"1s"} {"level":"info","ts":"2026-06-15T19:54:10.937628Z","caller":"traceutil/trace.go:171","msg":"trace[2134284929] linearizableReadLoop","detail":"{readStateIndex:418; appliedIndex:417; }","duration":"550.875634ms","start":"2026-06-15T19:54:10.38673Z","end":"2026-06-15T19:54:10.937606Z","steps":["trace[2134284929] 'read index received' (duration: 550.679453ms)","trace[2134284929] 'applied index is now lower than readState.Index' (duration: 195.181µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:54:10.937724Z","caller":"traceutil/trace.go:171","msg":"trace[568482327] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"1.342901563s","start":"2026-06-15T19:54:09.594814Z","end":"2026-06-15T19:54:10.937715Z","steps":["trace[568482327] 'process raft request' (duration: 1.342656481s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:10.937831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:09.594797Z","time spent":"1.342955243s","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:54:10.938028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.276608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-15T19:54:10.938144Z","caller":"traceutil/trace.go:171","msg":"trace[1863663453] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:402; }","duration":"551.473659ms","start":"2026-06-15T19:54:10.386651Z","end":"2026-06-15T19:54:10.938124Z","steps":["trace[1863663453] 'agreement among raft nodes before linearized reading' (duration: 551.220807ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:10.938075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.335918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.25\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-06-15T19:54:10.938198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:10.38663Z","time spent":"551.55726ms","remote":"127.0.0.1:44434","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":"info","ts":"2026-06-15T19:54:10.938304Z","caller":"traceutil/trace.go:171","msg":"trace[261443461] range","detail":"{range_begin:/registry/masterleases/199.204.45.25; range_end:; response_count:1; response_revision:402; }","duration":"128.670341ms","start":"2026-06-15T19:54:10.809607Z","end":"2026-06-15T19:54:10.938277Z","steps":["trace[261443461] 'agreement among raft nodes before linearized reading' (duration: 128.238568ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:11.50787Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986423222828190080,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-15T19:54:12.008356Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986423222828190080,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-15T19:54:12.074143Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.13435046s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-15T19:54:12.111796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:10.939635Z","time spent":"1.172156581s","remote":"127.0.0.1:44190","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-15T19:54:12.163517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.15630571s","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-06-15T19:54:12.163616Z","caller":"traceutil/trace.go:171","msg":"trace[1297117666] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:403; }","duration":"1.156451201s","start":"2026-06-15T19:54:11.007145Z","end":"2026-06-15T19:54:12.163596Z","steps":["trace[1297117666] 'agreement among raft nodes before linearized reading' (duration: 1.156176689s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:12.163663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:11.007125Z","time spent":"1.156528841s","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-15T19:54:12.164021Z","caller":"traceutil/trace.go:171","msg":"trace[2055107583] linearizableReadLoop","detail":"{readStateIndex:420; appliedIndex:418; }","duration":"1.151448634s","start":"2026-06-15T19:54:11.007195Z","end":"2026-06-15T19:54:12.158644Z","steps":["trace[2055107583] 'read index received' (duration: 1.067148759s)","trace[2055107583] 'applied index is now lower than readState.Index' (duration: 84.298485ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:54:12.164149Z","caller":"traceutil/trace.go:171","msg":"trace[1537107894] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"1.221439816s","start":"2026-06-15T19:54:10.942687Z","end":"2026-06-15T19:54:12.164127Z","steps":["trace[1537107894] 'process raft request' (duration: 1.215740124s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:12.164268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:10.94266Z","time spent":"1.221556598s","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:54:12.637205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.250174ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:54:12.637368Z","caller":"traceutil/trace.go:171","msg":"trace[1109247686] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"524.145627ms","start":"2026-06-15T19:54:12.11318Z","end":"2026-06-15T19:54:12.637325Z","steps":["trace[1109247686] 'process raft request' (duration: 102.658161ms)","trace[1109247686] 'compare' (duration: 421.109512ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:54:12.637526Z","caller":"traceutil/trace.go:171","msg":"trace[246700585] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"468.504266ms","start":"2026-06-15T19:54:12.168925Z","end":"2026-06-15T19:54:12.637429Z","steps":["trace[246700585] 'process raft request' (duration: 468.388934ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:12.637543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:12.113159Z","time spent":"524.29514ms","remote":"127.0.0.1:44190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:54:12.637662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:12.168904Z","time spent":"468.666657ms","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:54:12.6377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.381379925s","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-06-15T19:54:12.637789Z","caller":"traceutil/trace.go:171","msg":"trace[911588805] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:405; }","duration":"1.381523256s","start":"2026-06-15T19:54:11.256251Z","end":"2026-06-15T19:54:12.637774Z","steps":["trace[911588805] 'agreement among raft nodes before linearized reading' (duration: 1.381330933s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:12.637835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:11.256231Z","time spent":"1.381595247s","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-15T19:54:12.638164Z","caller":"traceutil/trace.go:171","msg":"trace[604626369] linearizableReadLoop","detail":"{readStateIndex:421; appliedIndex:420; }","duration":"473.413572ms","start":"2026-06-15T19:54:12.16406Z","end":"2026-06-15T19:54:12.637474Z","steps":["trace[604626369] 'read index received' (duration: 51.791694ms)","trace[604626369] 'applied index is now lower than readState.Index' (duration: 421.616168ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:54:13.142136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.881158ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:54:13.142244Z","caller":"traceutil/trace.go:171","msg":"trace[1265086408] linearizableReadLoop","detail":"{readStateIndex:423; appliedIndex:422; }","duration":"498.968825ms","start":"2026-06-15T19:54:12.643258Z","end":"2026-06-15T19:54:13.142227Z","steps":["trace[1265086408] 'read index received' (duration: 143.853858ms)","trace[1265086408] 'applied index is now lower than readState.Index' (duration: 355.113537ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:54:13.142331Z","caller":"traceutil/trace.go:171","msg":"trace[91431637] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"500.288074ms","start":"2026-06-15T19:54:12.642032Z","end":"2026-06-15T19:54:13.14232Z","steps":["trace[91431637] 'process raft request' (duration: 145.133874ms)","trace[91431637] 'compare' (duration: 354.540832ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:54:13.142387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:12.64202Z","time spent":"500.337626ms","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:54:13.14244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.178004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-06-15T19:54:13.142438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.286836ms","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-06-15T19:54:13.1425Z","caller":"traceutil/trace.go:171","msg":"trace[1535472272] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:406; }","duration":"499.304989ms","start":"2026-06-15T19:54:12.643182Z","end":"2026-06-15T19:54:13.142487Z","steps":["trace[1535472272] 'agreement among raft nodes before linearized reading' (duration: 499.191894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:13.142534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:12.643153Z","time spent":"499.375281ms","remote":"127.0.0.1:44440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"info","ts":"2026-06-15T19:54:13.142526Z","caller":"traceutil/trace.go:171","msg":"trace[1944211274] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:406; }","duration":"200.432882ms","start":"2026-06-15T19:54:12.942071Z","end":"2026-06-15T19:54:13.142504Z","steps":["trace[1944211274] 'agreement among raft nodes before linearized reading' (duration: 200.280925ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:13.44783Z","caller":"traceutil/trace.go:171","msg":"trace[1868202832] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"279.621371ms","start":"2026-06-15T19:54:13.168072Z","end":"2026-06-15T19:54:13.447693Z","steps":["trace[1868202832] 'process raft request' (duration: 184.443065ms)","trace[1868202832] 'compare' (duration: 94.547747ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:54:15.260598Z","caller":"traceutil/trace.go:171","msg":"trace[879762660] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"107.538494ms","start":"2026-06-15T19:54:15.153021Z","end":"2026-06-15T19:54:15.260559Z","steps":["trace[879762660] 'process raft request' (duration: 21.83275ms)","trace[879762660] 'compare' (duration: 85.445053ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:54:15.503284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.649572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:54:15.503415Z","caller":"traceutil/trace.go:171","msg":"trace[1533300541] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:416; }","duration":"117.806409ms","start":"2026-06-15T19:54:15.385578Z","end":"2026-06-15T19:54:15.503385Z","steps":["trace[1533300541] 'range keys from in-memory index tree' (duration: 117.557748ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:16.383318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.26963ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-15T19:54:16.383452Z","caller":"traceutil/trace.go:171","msg":"trace[1037559306] linearizableReadLoop","detail":"{readStateIndex:434; appliedIndex:433; }","duration":"135.214482ms","start":"2026-06-15T19:54:16.248217Z","end":"2026-06-15T19:54:16.383431Z","steps":["trace[1037559306] 'read index received' (duration: 759.204µs)","trace[1037559306] 'applied index is now lower than readState.Index' (duration: 134.453678ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:54:16.383569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.346307ms","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-06-15T19:54:16.383598Z","caller":"traceutil/trace.go:171","msg":"trace[2047884273] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:416; }","duration":"135.425341ms","start":"2026-06-15T19:54:16.248162Z","end":"2026-06-15T19:54:16.383587Z","steps":["trace[2047884273] 'agreement among raft nodes before linearized reading' (duration: 135.333337ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:21.796971Z","caller":"traceutil/trace.go:171","msg":"trace[24173173] linearizableReadLoop","detail":"{readStateIndex:448; appliedIndex:447; }","duration":"463.94796ms","start":"2026-06-15T19:54:21.332998Z","end":"2026-06-15T19:54:21.796946Z","steps":["trace[24173173] 'read index received' (duration: 463.647968ms)","trace[24173173] 'applied index is now lower than readState.Index' (duration: 298.842µs)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:54:21.797092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.080796ms","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-06-15T19:54:21.797124Z","caller":"traceutil/trace.go:171","msg":"trace[1222794583] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:429; }","duration":"464.167159ms","start":"2026-06-15T19:54:21.332947Z","end":"2026-06-15T19:54:21.797114Z","steps":["trace[1222794583] 'agreement among raft nodes before linearized reading' (duration: 464.089476ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:21.797158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:21.332926Z","time spent":"464.224862ms","remote":"127.0.0.1:44434","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":"info","ts":"2026-06-15T19:54:21.797122Z","caller":"traceutil/trace.go:171","msg":"trace[678830953] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"506.621746ms","start":"2026-06-15T19:54:21.290445Z","end":"2026-06-15T19:54:21.797067Z","steps":["trace[678830953] 'process raft request' (duration: 506.315554ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:21.797301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:21.290424Z","time spent":"506.791103ms","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:54:37.034943Z","caller":"traceutil/trace.go:171","msg":"trace[1178844252] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"133.642688ms","start":"2026-06-15T19:54:36.901282Z","end":"2026-06-15T19:54:37.034925Z","steps":["trace[1178844252] 'process raft request' (duration: 133.534714ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:37.663605Z","caller":"traceutil/trace.go:171","msg":"trace[1298395054] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"108.381188ms","start":"2026-06-15T19:54:37.555198Z","end":"2026-06-15T19:54:37.663579Z","steps":["trace[1298395054] 'process raft request' (duration: 108.061107ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:37.88035Z","caller":"traceutil/trace.go:171","msg":"trace[1784797553] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"192.229695ms","start":"2026-06-15T19:54:37.688082Z","end":"2026-06-15T19:54:37.880312Z","steps":["trace[1784797553] 'process raft request' (duration: 148.630088ms)","trace[1784797553] 'compare' (duration: 43.295246ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:54:37.880504Z","caller":"traceutil/trace.go:171","msg":"trace[135544259] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"191.605263ms","start":"2026-06-15T19:54:37.688871Z","end":"2026-06-15T19:54:37.880476Z","steps":["trace[135544259] 'process raft request' (duration: 191.491769ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:39.798887Z","caller":"traceutil/trace.go:171","msg":"trace[1198588928] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"121.534761ms","start":"2026-06-15T19:54:39.677334Z","end":"2026-06-15T19:54:39.798869Z","steps":["trace[1198588928] 'process raft request' (duration: 121.432858ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:40.166452Z","caller":"traceutil/trace.go:171","msg":"trace[407719407] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"486.525842ms","start":"2026-06-15T19:54:39.679886Z","end":"2026-06-15T19:54:40.166412Z","steps":["trace[407719407] 'process raft request' (duration: 486.251023ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:40.166532Z","caller":"traceutil/trace.go:171","msg":"trace[1022646387] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"476.602967ms","start":"2026-06-15T19:54:39.689897Z","end":"2026-06-15T19:54:40.1665Z","steps":["trace[1022646387] 'process raft request' (duration: 476.472133ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:40.166619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:39.679867Z","time spent":"486.679357ms","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-15T19:54:40.166764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:39.68988Z","time spent":"476.742751ms","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:54:40.166776Z","caller":"traceutil/trace.go:171","msg":"trace[1524524472] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"473.087987ms","start":"2026-06-15T19:54:39.693664Z","end":"2026-06-15T19:54:40.166752Z","steps":["trace[1524524472] 'process raft request' (duration: 472.763046ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:40.166875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:39.693651Z","time spent":"473.179401ms","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:54:40.166968Z","caller":"traceutil/trace.go:171","msg":"trace[703704923] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"439.869474ms","start":"2026-06-15T19:54:39.727083Z","end":"2026-06-15T19:54:40.166952Z","steps":["trace[703704923] 'process raft request' (duration: 439.693458ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:40.166977Z","caller":"traceutil/trace.go:171","msg":"trace[615774598] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"435.586468ms","start":"2026-06-15T19:54:39.731369Z","end":"2026-06-15T19:54:40.166956Z","steps":["trace[615774598] 'process raft request' (duration: 435.524066ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:40.167058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:39.727066Z","time spent":"439.942657ms","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-15T19:54:40.167076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:39.731331Z","time spent":"435.697432ms","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:54:40.166529Z","caller":"traceutil/trace.go:171","msg":"trace[283038775] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"480.769027ms","start":"2026-06-15T19:54:39.685718Z","end":"2026-06-15T19:54:40.166487Z","steps":["trace[283038775] 'process raft request' (duration: 480.586831ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:40.167206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:39.685707Z","time spent":"481.478872ms","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-15T19:54:40.544307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.6514ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:54:40.544641Z","caller":"traceutil/trace.go:171","msg":"trace[899408255] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:542; }","duration":"293.986351ms","start":"2026-06-15T19:54:40.250616Z","end":"2026-06-15T19:54:40.544602Z","steps":["trace[899408255] 'range keys from in-memory index tree' (duration: 293.625679ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:40.570183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.973509ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:54:40.570487Z","caller":"traceutil/trace.go:171","msg":"trace[1033067874] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"765.890959ms","start":"2026-06-15T19:54:39.804556Z","end":"2026-06-15T19:54:40.570447Z","steps":["trace[1033067874] 'process raft request' (duration: 460.592589ms)","trace[1033067874] 'compare' (duration: 297.575642ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:54:40.57061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:39.804543Z","time spent":"766.001223ms","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:54:40.571081Z","caller":"traceutil/trace.go:171","msg":"trace[1952216961] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"755.323312ms","start":"2026-06-15T19:54:39.815746Z","end":"2026-06-15T19:54:40.571069Z","steps":["trace[1952216961] 'process raft request' (duration: 754.620177ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:40.571136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:39.815734Z","time spent":"755.380414ms","remote":"127.0.0.1:44670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:54:40.571174Z","caller":"traceutil/trace.go:171","msg":"trace[1619942339] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"761.242453ms","start":"2026-06-15T19:54:39.80992Z","end":"2026-06-15T19:54:40.571163Z","steps":["trace[1619942339] 'process raft request' (duration: 760.359153ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:40.571228Z","caller":"traceutil/trace.go:171","msg":"trace[1092313576] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"754.912918ms","start":"2026-06-15T19:54:39.816296Z","end":"2026-06-15T19:54:40.571209Z","steps":["trace[1092313576] 'process raft request' (duration: 754.110541ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:40.571281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:39.816289Z","time spent":"754.954219ms","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:54:40.571257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:39.809903Z","time spent":"761.327345ms","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:54:40.571363Z","caller":"traceutil/trace.go:171","msg":"trace[1221162605] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"748.715628ms","start":"2026-06-15T19:54:39.822631Z","end":"2026-06-15T19:54:40.571347Z","steps":["trace[1221162605] 'process raft request' (duration: 747.870749ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:40.571402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:39.822595Z","time spent":"748.789491ms","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:54:40.571596Z","caller":"traceutil/trace.go:171","msg":"trace[163039738] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"731.518216ms","start":"2026-06-15T19:54:39.840065Z","end":"2026-06-15T19:54:40.571583Z","steps":["trace[163039738] 'process raft request' (duration: 730.529453ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:40.571655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:39.84004Z","time spent":"731.586288ms","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:54:40.576788Z","caller":"traceutil/trace.go:171","msg":"trace[1999264227] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:560; }","duration":"655.868405ms","start":"2026-06-15T19:54:39.920889Z","end":"2026-06-15T19:54:40.576758Z","steps":["trace[1999264227] 'read index received' (duration: 245.429075ms)","trace[1999264227] 'applied index is now lower than readState.Index' (duration: 410.43867ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:54:40.576839Z","caller":"traceutil/trace.go:171","msg":"trace[272736252] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"636.53366ms","start":"2026-06-15T19:54:39.9403Z","end":"2026-06-15T19:54:40.576834Z","steps":["trace[272736252] 'process raft request' (duration: 632.04042ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:40.576881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:39.940258Z","time spent":"636.593932ms","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-15T19:54:40.576969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.085792ms","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-06-15T19:54:40.576991Z","caller":"traceutil/trace.go:171","msg":"trace[1343521402] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:549; }","duration":"656.373182ms","start":"2026-06-15T19:54:39.920611Z","end":"2026-06-15T19:54:40.576984Z","steps":["trace[1343521402] 'agreement among raft nodes before linearized reading' (duration: 656.31528ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:40.577008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:39.920582Z","time spent":"656.422754ms","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-15T19:54:40.726168Z","caller":"traceutil/trace.go:171","msg":"trace[1455430747] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"553.417916ms","start":"2026-06-15T19:54:40.172725Z","end":"2026-06-15T19:54:40.726143Z","steps":["trace[1455430747] 'process raft request' (duration: 550.728576ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:40.726319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:40.172706Z","time spent":"553.54139ms","remote":"127.0.0.1:44670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:54:40.726645Z","caller":"traceutil/trace.go:171","msg":"trace[288271200] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"550.071754ms","start":"2026-06-15T19:54:40.17654Z","end":"2026-06-15T19:54:40.726612Z","steps":["trace[288271200] 'process raft request' (duration: 549.550587ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:40.726821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:40.176534Z","time spent":"550.203438ms","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:54:40.726949Z","caller":"traceutil/trace.go:171","msg":"trace[885083871] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"548.197421ms","start":"2026-06-15T19:54:40.178741Z","end":"2026-06-15T19:54:40.726938Z","steps":["trace[885083871] 'process raft request' (duration: 547.587501ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:40.727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:40.178732Z","time spent":"548.238422ms","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:54:40.727153Z","caller":"traceutil/trace.go:171","msg":"trace[416234817] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"548.029076ms","start":"2026-06-15T19:54:40.179113Z","end":"2026-06-15T19:54:40.727142Z","steps":["trace[416234817] 'process raft request' (duration: 547.24915ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:40.727325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:40.179105Z","time spent":"548.070707ms","remote":"127.0.0.1:44670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:54:40.726203Z","caller":"traceutil/trace.go:171","msg":"trace[1312844049] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"552.220616ms","start":"2026-06-15T19:54:40.173956Z","end":"2026-06-15T19:54:40.726176Z","steps":["trace[1312844049] 'process raft request' (duration: 552.101862ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:40.727935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:40.173948Z","time spent":"553.945243ms","remote":"127.0.0.1:44670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:54:40.729907Z","caller":"traceutil/trace.go:171","msg":"trace[1989444171] linearizableReadLoop","detail":"{readStateIndex:579; appliedIndex:572; }","duration":"153.081844ms","start":"2026-06-15T19:54:40.576812Z","end":"2026-06-15T19:54:40.729894Z","steps":["trace[1989444171] 'read index received' (duration: 146.70611ms)","trace[1989444171] 'applied index is now lower than readState.Index' (duration: 6.375114ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:54:40.729994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"790.471663ms","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-06-15T19:54:40.730047Z","caller":"traceutil/trace.go:171","msg":"trace[1520909301] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:556; }","duration":"790.575868ms","start":"2026-06-15T19:54:39.939462Z","end":"2026-06-15T19:54:40.730038Z","steps":["trace[1520909301] 'agreement among raft nodes before linearized reading' (duration: 790.472344ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:40.730077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:39.939443Z","time spent":"790.628409ms","remote":"127.0.0.1:44434","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":"info","ts":"2026-06-15T19:54:40.730312Z","caller":"traceutil/trace.go:171","msg":"trace[1558215917] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"546.746083ms","start":"2026-06-15T19:54:40.183559Z","end":"2026-06-15T19:54:40.730305Z","steps":["trace[1558215917] 'process raft request' (duration: 542.857793ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:40.730358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:40.183532Z","time spent":"546.796095ms","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:54:40.730435Z","caller":"traceutil/trace.go:171","msg":"trace[818866] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"540.800543ms","start":"2026-06-15T19:54:40.189629Z","end":"2026-06-15T19:54:40.730429Z","steps":["trace[818866] 'process raft request' (duration: 540.205953ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:40.730466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:40.189609Z","time spent":"540.839705ms","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:54:40.730552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.6461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-15T19:54:40.730571Z","caller":"traceutil/trace.go:171","msg":"trace[657786692] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:556; }","duration":"204.729454ms","start":"2026-06-15T19:54:40.525837Z","end":"2026-06-15T19:54:40.730566Z","steps":["trace[657786692] 'agreement among raft nodes before linearized reading' (duration: 204.691333ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:40.730681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.90068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:54:40.730731Z","caller":"traceutil/trace.go:171","msg":"trace[946053292] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:556; }","duration":"345.986853ms","start":"2026-06-15T19:54:40.384735Z","end":"2026-06-15T19:54:40.730722Z","steps":["trace[946053292] 'agreement among raft nodes before linearized reading' (duration: 345.910641ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:40.730752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:40.384714Z","time spent":"346.033474ms","remote":"127.0.0.1:44158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-15T19:54:40.799396Z","caller":"traceutil/trace.go:171","msg":"trace[283879291] transaction","detail":"{read_only:false; number_of_response:0; response_revision:556; }","duration":"222.179028ms","start":"2026-06-15T19:54:40.577196Z","end":"2026-06-15T19:54:40.799375Z","steps":["trace[283879291] 'process raft request' (duration: 222.000162ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:40.799513Z","caller":"traceutil/trace.go:171","msg":"trace[296128906] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"204.356151ms","start":"2026-06-15T19:54:40.595128Z","end":"2026-06-15T19:54:40.799485Z","steps":["trace[296128906] 'process raft request' (duration: 204.141054ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:40.799546Z","caller":"traceutil/trace.go:171","msg":"trace[293477980] transaction","detail":"{read_only:false; number_of_response:1; response_revision:557; }","duration":"180.73363ms","start":"2026-06-15T19:54:40.618784Z","end":"2026-06-15T19:54:40.799518Z","steps":["trace[293477980] 'process raft request' (duration: 180.569844ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:40.799976Z","caller":"traceutil/trace.go:171","msg":"trace[1310511442] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"177.431819ms","start":"2026-06-15T19:54:40.622533Z","end":"2026-06-15T19:54:40.799965Z","steps":["trace[1310511442] 'process raft request' (duration: 176.84777ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:40.799973Z","caller":"traceutil/trace.go:171","msg":"trace[1060101420] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"160.073738ms","start":"2026-06-15T19:54:40.639887Z","end":"2026-06-15T19:54:40.79996Z","steps":["trace[1060101420] 'process raft request' (duration: 159.609793ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:40.799966Z","caller":"traceutil/trace.go:171","msg":"trace[1792141174] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"100.701971ms","start":"2026-06-15T19:54:40.699246Z","end":"2026-06-15T19:54:40.799948Z","steps":["trace[1792141174] 'process raft request' (duration: 100.349339ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:40.800077Z","caller":"traceutil/trace.go:171","msg":"trace[735518942] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"118.878269ms","start":"2026-06-15T19:54:40.681193Z","end":"2026-06-15T19:54:40.800071Z","steps":["trace[735518942] 'process raft request' (duration: 118.339451ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:41.573046Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986423222828190411,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-15T19:54:41.869015Z","caller":"traceutil/trace.go:171","msg":"trace[1235487491] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"947.316716ms","start":"2026-06-15T19:54:40.921674Z","end":"2026-06-15T19:54:41.86899Z","steps":["trace[1235487491] 'process raft request' (duration: 908.425568ms)","trace[1235487491] 'compare' (duration: 38.366631ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:54:41.869179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:40.921629Z","time spent":"947.456931ms","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31102,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:54:42.043192Z","caller":"traceutil/trace.go:171","msg":"trace[480793362] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:603; }","duration":"970.218382ms","start":"2026-06-15T19:54:41.072946Z","end":"2026-06-15T19:54:42.043164Z","steps":["trace[480793362] 'read index received' (duration: 757.116798ms)","trace[480793362] 'applied index is now lower than readState.Index' (duration: 213.100364ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:54:42.043234Z","caller":"traceutil/trace.go:171","msg":"trace[1778894579] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"1.119101131s","start":"2026-06-15T19:54:40.924081Z","end":"2026-06-15T19:54:42.043182Z","steps":["trace[1778894579] 'process raft request' (duration: 1.088249729s)","trace[1778894579] 'compare' (duration: 30.616904ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:54:42.043314Z","caller":"traceutil/trace.go:171","msg":"trace[1797107263] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"1.118690637s","start":"2026-06-15T19:54:40.924611Z","end":"2026-06-15T19:54:42.043301Z","steps":["trace[1797107263] 'process raft request' (duration: 1.118491591s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:42.043419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:40.92406Z","time spent":"1.119258476s","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:54:42.043543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:40.9246Z","time spent":"1.118746409s","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-15T19:54:42.043587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"970.560404ms","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-06-15T19:54:42.043792Z","caller":"traceutil/trace.go:171","msg":"trace[1478134499] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:577; }","duration":"970.886704ms","start":"2026-06-15T19:54:41.072887Z","end":"2026-06-15T19:54:42.043774Z","steps":["trace[1478134499] 'agreement among raft nodes before linearized reading' (duration: 970.46343ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:42.043852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:41.072864Z","time spent":"970.974377ms","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-15T19:54:42.202626Z","caller":"traceutil/trace.go:171","msg":"trace[1324103660] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"322.142891ms","start":"2026-06-15T19:54:41.880438Z","end":"2026-06-15T19:54:42.202581Z","steps":["trace[1324103660] 'process raft request' (duration: 274.593082ms)","trace[1324103660] 'compare' (duration: 47.427095ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:54:42.202832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:41.880381Z","time spent":"322.352247ms","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23057,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:54:42.202901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"818.016795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:54:42.203041Z","caller":"traceutil/trace.go:171","msg":"trace[909992456] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:578; }","duration":"818.197411ms","start":"2026-06-15T19:54:41.384817Z","end":"2026-06-15T19:54:42.203015Z","steps":["trace[909992456] 'agreement among raft nodes before linearized reading' (duration: 817.933862ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:42.203108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:41.384755Z","time spent":"818.342846ms","remote":"127.0.0.1:44158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-15T19:54:42.203303Z","caller":"traceutil/trace.go:171","msg":"trace[6646979] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:606; }","duration":"159.971973ms","start":"2026-06-15T19:54:42.04327Z","end":"2026-06-15T19:54:42.203242Z","steps":["trace[6646979] 'read index received' (duration: 111.778074ms)","trace[6646979] 'applied index is now lower than readState.Index' (duration: 47.612921ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:54:42.211236Z","caller":"traceutil/trace.go:171","msg":"trace[1255201646] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"162.02943ms","start":"2026-06-15T19:54:42.049168Z","end":"2026-06-15T19:54:42.211197Z","steps":["trace[1255201646] 'process raft request' (duration: 161.830243ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:42.211391Z","caller":"traceutil/trace.go:171","msg":"trace[331647129] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"151.04347ms","start":"2026-06-15T19:54:42.060333Z","end":"2026-06-15T19:54:42.211377Z","steps":["trace[331647129] 'process raft request' (duration: 150.776271ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:42.211441Z","caller":"traceutil/trace.go:171","msg":"trace[1161526661] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"110.671566ms","start":"2026-06-15T19:54:42.100756Z","end":"2026-06-15T19:54:42.211427Z","steps":["trace[1161526661] 'process raft request' (duration: 110.422208ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:42.337985Z","caller":"traceutil/trace.go:171","msg":"trace[1701974223] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"114.697289ms","start":"2026-06-15T19:54:42.223247Z","end":"2026-06-15T19:54:42.337945Z","steps":["trace[1701974223] 'process raft request' (duration: 101.639712ms)","trace[1701974223] 'compare' (duration: 12.265571ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:54:43.099932Z","caller":"traceutil/trace.go:171","msg":"trace[1152793293] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"224.532496ms","start":"2026-06-15T19:54:42.875359Z","end":"2026-06-15T19:54:43.099891Z","steps":["trace[1152793293] 'process raft request' (duration: 160.968345ms)","trace[1152793293] 'compare' (duration: 63.160088ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:54:43.101335Z","caller":"traceutil/trace.go:171","msg":"trace[553272761] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"219.408057ms","start":"2026-06-15T19:54:42.881893Z","end":"2026-06-15T19:54:43.101301Z","steps":["trace[553272761] 'process raft request' (duration: 217.932349ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:43.112005Z","caller":"traceutil/trace.go:171","msg":"trace[1077253665] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"123.439558ms","start":"2026-06-15T19:54:42.988529Z","end":"2026-06-15T19:54:43.111969Z","steps":["trace[1077253665] 'process raft request' (duration: 113.280099ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:43.597268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.221807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:29570"} {"level":"info","ts":"2026-06-15T19:54:43.597365Z","caller":"traceutil/trace.go:171","msg":"trace[753139852] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:615; }","duration":"185.383622ms","start":"2026-06-15T19:54:43.41196Z","end":"2026-06-15T19:54:43.597344Z","steps":["trace[753139852] 'range keys from in-memory index tree' (duration: 185.01143ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:43.601522Z","caller":"traceutil/trace.go:171","msg":"trace[1339951431] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"182.082586ms","start":"2026-06-15T19:54:43.419399Z","end":"2026-06-15T19:54:43.601481Z","steps":["trace[1339951431] 'process raft request' (duration: 181.697083ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:43.684357Z","caller":"traceutil/trace.go:171","msg":"trace[782190727] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"207.917683ms","start":"2026-06-15T19:54:43.476417Z","end":"2026-06-15T19:54:43.684334Z","steps":["trace[782190727] 'process raft request' (duration: 207.594783ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:43.91017Z","caller":"traceutil/trace.go:171","msg":"trace[818607691] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"215.022044ms","start":"2026-06-15T19:54:43.695118Z","end":"2026-06-15T19:54:43.91014Z","steps":["trace[818607691] 'read index received' (duration: 119.502756ms)","trace[818607691] 'applied index is now lower than readState.Index' (duration: 95.518028ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:54:43.910318Z","caller":"traceutil/trace.go:171","msg":"trace[2132099838] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"262.043629ms","start":"2026-06-15T19:54:43.648224Z","end":"2026-06-15T19:54:43.910268Z","steps":["trace[2132099838] 'process raft request' (duration: 166.409537ms)","trace[2132099838] 'compare' (duration: 95.367844ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:54:43.910427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.287672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:59631"} {"level":"info","ts":"2026-06-15T19:54:43.911101Z","caller":"traceutil/trace.go:171","msg":"trace[2085971566] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:618; }","duration":"215.387496ms","start":"2026-06-15T19:54:43.695067Z","end":"2026-06-15T19:54:43.910454Z","steps":["trace[2085971566] 'agreement among raft nodes before linearized reading' (duration: 215.181699ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:44.296391Z","caller":"traceutil/trace.go:171","msg":"trace[1833104603] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:647; }","duration":"274.083616ms","start":"2026-06-15T19:54:44.022285Z","end":"2026-06-15T19:54:44.296369Z","steps":["trace[1833104603] 'read index received' (duration: 273.90426ms)","trace[1833104603] 'applied index is now lower than readState.Index' (duration: 178.546µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:54:44.296535Z","caller":"traceutil/trace.go:171","msg":"trace[2019329216] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"316.719464ms","start":"2026-06-15T19:54:43.979774Z","end":"2026-06-15T19:54:44.296494Z","steps":["trace[2019329216] 'process raft request' (duration: 316.346911ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:44.296663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.363095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"info","ts":"2026-06-15T19:54:44.29672Z","caller":"traceutil/trace.go:171","msg":"trace[1285596624] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:619; }","duration":"274.48096ms","start":"2026-06-15T19:54:44.022226Z","end":"2026-06-15T19:54:44.296707Z","steps":["trace[1285596624] 'agreement among raft nodes before linearized reading' (duration: 274.288054ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:44.296719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:43.979754Z","time spent":"316.878958ms","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208470,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:54:44.310356Z","caller":"traceutil/trace.go:171","msg":"trace[972715444] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"180.460391ms","start":"2026-06-15T19:54:44.129873Z","end":"2026-06-15T19:54:44.310333Z","steps":["trace[972715444] 'process raft request' (duration: 179.996257ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:47.539084Z","caller":"traceutil/trace.go:171","msg":"trace[333683334] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:664; }","duration":"154.279671ms","start":"2026-06-15T19:54:47.384786Z","end":"2026-06-15T19:54:47.539065Z","steps":["trace[333683334] 'read index received' (duration: 153.699463ms)","trace[333683334] 'applied index is now lower than readState.Index' (duration: 579.598µs)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:54:47.539179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.385034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:54:47.539196Z","caller":"traceutil/trace.go:171","msg":"trace[535969906] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"154.447486ms","start":"2026-06-15T19:54:47.384742Z","end":"2026-06-15T19:54:47.53919Z","steps":["trace[535969906] 'agreement among raft nodes before linearized reading' (duration: 154.389314ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:47.539324Z","caller":"traceutil/trace.go:171","msg":"trace[576571848] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"210.912153ms","start":"2026-06-15T19:54:47.328391Z","end":"2026-06-15T19:54:47.539303Z","steps":["trace[576571848] 'process raft request' (duration: 210.320495ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:48.876224Z","caller":"traceutil/trace.go:171","msg":"trace[116459487] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:666; }","duration":"497.075578ms","start":"2026-06-15T19:54:48.379113Z","end":"2026-06-15T19:54:48.876188Z","steps":["trace[116459487] 'read index received' (duration: 496.107799ms)","trace[116459487] 'applied index is now lower than readState.Index' (duration: 966.679µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:54:48.876302Z","caller":"traceutil/trace.go:171","msg":"trace[593747513] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"831.529379ms","start":"2026-06-15T19:54:48.044723Z","end":"2026-06-15T19:54:48.876252Z","steps":["trace[593747513] 'process raft request' (duration: 830.932261ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:48.876508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:48.044692Z","time spent":"831.686445ms","remote":"127.0.0.1:44262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036193,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:54:48.876541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.342917ms","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-06-15T19:54:48.87663Z","caller":"traceutil/trace.go:171","msg":"trace[91107747] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:637; }","duration":"497.548063ms","start":"2026-06-15T19:54:48.379061Z","end":"2026-06-15T19:54:48.876609Z","steps":["trace[91107747] 'agreement among raft nodes before linearized reading' (duration: 497.229503ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:48.876687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:48.379026Z","time spent":"497.650586ms","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-15T19:54:48.876659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.30287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:54:48.876806Z","caller":"traceutil/trace.go:171","msg":"trace[1966186869] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"491.508568ms","start":"2026-06-15T19:54:48.385263Z","end":"2026-06-15T19:54:48.876771Z","steps":["trace[1966186869] 'agreement among raft nodes before linearized reading' (duration: 491.202757ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:48.876874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:48.385243Z","time spent":"491.621152ms","remote":"127.0.0.1:44158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-15T19:54:50.331435Z","caller":"traceutil/trace.go:171","msg":"trace[1898440600] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"961.577854ms","start":"2026-06-15T19:54:49.369834Z","end":"2026-06-15T19:54:50.331412Z","steps":["trace[1898440600] 'process raft request' (duration: 960.174851ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:50.331582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:49.369807Z","time spent":"961.700698ms","remote":"127.0.0.1:44262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036229,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:54:51.322857Z","caller":"traceutil/trace.go:171","msg":"trace[1090915691] linearizableReadLoop","detail":"{readStateIndex:677; appliedIndex:675; }","duration":"1.406061175s","start":"2026-06-15T19:54:49.916711Z","end":"2026-06-15T19:54:51.322772Z","steps":["trace[1090915691] 'read index received' (duration: 412.704822ms)","trace[1090915691] 'applied index is now lower than readState.Index' (duration: 993.354563ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:54:51.3229Z","caller":"traceutil/trace.go:171","msg":"trace[353626936] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"1.420423513s","start":"2026-06-15T19:54:49.902439Z","end":"2026-06-15T19:54:51.322863Z","steps":["trace[353626936] 'process raft request' (duration: 1.419974719s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:51.32309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.406347244s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-sh6xf\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-15T19:54:51.323139Z","caller":"traceutil/trace.go:171","msg":"trace[1032073033] range","detail":"{range_begin:/registry/pods/kube-system/cilium-sh6xf; range_end:; response_count:1; response_revision:647; }","duration":"1.406428256s","start":"2026-06-15T19:54:49.916695Z","end":"2026-06-15T19:54:51.323124Z","steps":["trace[1032073033] 'agreement among raft nodes before linearized reading' (duration: 1.406294552s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:51.323186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:49.91665Z","time spent":"1.406526589s","remote":"127.0.0.1:44372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-sh6xf\" "} {"level":"warn","ts":"2026-06-15T19:54:51.323202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:49.902415Z","time spent":"1.42065015s","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:54:51.404742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.021462037s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:54:51.404803Z","caller":"traceutil/trace.go:171","msg":"trace[608962404] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"1.01326194s","start":"2026-06-15T19:54:50.391503Z","end":"2026-06-15T19:54:51.404765Z","steps":["trace[608962404] 'process raft request' (duration: 967.684988ms)","trace[608962404] 'compare' (duration: 45.301443ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:54:51.404839Z","caller":"traceutil/trace.go:171","msg":"trace[870655032] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:648; }","duration":"1.021617691s","start":"2026-06-15T19:54:50.383205Z","end":"2026-06-15T19:54:51.404822Z","steps":["trace[870655032] 'agreement among raft nodes before linearized reading' (duration: 1.021433006s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:51.404883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:50.383184Z","time spent":"1.021687704s","remote":"127.0.0.1:44158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-15T19:54:51.404925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.096527ms","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-06-15T19:54:51.405021Z","caller":"traceutil/trace.go:171","msg":"trace[1641994149] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:648; }","duration":"378.249251ms","start":"2026-06-15T19:54:51.026751Z","end":"2026-06-15T19:54:51.405Z","steps":["trace[1641994149] 'agreement among raft nodes before linearized reading' (duration: 377.962073ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:51.405076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:51.026736Z","time spent":"378.331143ms","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-15T19:54:51.40519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:50.391487Z","time spent":"1.013379102s","remote":"127.0.0.1:44506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-15T19:54:51.405319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.613602ms","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-06-15T19:54:51.405397Z","caller":"traceutil/trace.go:171","msg":"trace[1656430187] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:648; }","duration":"476.675494ms","start":"2026-06-15T19:54:50.92869Z","end":"2026-06-15T19:54:51.405366Z","steps":["trace[1656430187] 'agreement among raft nodes before linearized reading' (duration: 476.498379ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:51.405454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:50.928651Z","time spent":"476.790387ms","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-15T19:54:51.405621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.687464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.25\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-15T19:54:51.405747Z","caller":"traceutil/trace.go:171","msg":"trace[1410413762] range","detail":"{range_begin:/registry/masterleases/199.204.45.25; range_end:; response_count:1; response_revision:648; }","duration":"592.872181ms","start":"2026-06-15T19:54:50.812846Z","end":"2026-06-15T19:54:51.405718Z","steps":["trace[1410413762] 'agreement among raft nodes before linearized reading' (duration: 592.50414ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:51.405804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:50.812826Z","time spent":"592.968213ms","remote":"127.0.0.1:44190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.25\" "} {"level":"warn","ts":"2026-06-15T19:54:51.405973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.656435ms","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-06-15T19:54:51.406107Z","caller":"traceutil/trace.go:171","msg":"trace[2007837053] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:648; }","duration":"362.81472ms","start":"2026-06-15T19:54:51.043278Z","end":"2026-06-15T19:54:51.406093Z","steps":["trace[2007837053] 'agreement among raft nodes before linearized reading' (duration: 362.039517ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:51.40701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:51.043267Z","time spent":"363.691656ms","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-15T19:54:51.405673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.991931ms","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-06-15T19:54:51.407412Z","caller":"traceutil/trace.go:171","msg":"trace[1725920955] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:648; }","duration":"517.61313ms","start":"2026-06-15T19:54:50.889642Z","end":"2026-06-15T19:54:51.407255Z","steps":["trace[1725920955] 'agreement among raft nodes before linearized reading' (duration: 515.95344ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:51.407496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:50.88963Z","time spent":"517.844097ms","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-15T19:54:51.907695Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986423222828190557,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-15T19:54:52.408164Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986423222828190557,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-15T19:54:52.525161Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.165863198s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-15T19:54:53.407082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.99999683s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-06-15T19:54:53.407148Z","caller":"traceutil/trace.go:171","msg":"trace[1135039661] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000112753s","start":"2026-06-15T19:54:51.407021Z","end":"2026-06-15T19:54:53.407134Z","steps":["trace[1135039661] 'agreement among raft nodes before linearized reading' (duration: 2.000021281s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:53.407179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:51.407Z","time spent":"2.000173414s","remote":"127.0.0.1:44166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-15T19:54:53.509338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"983.834315ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:54:53.509704Z","caller":"traceutil/trace.go:171","msg":"trace[1686559877] linearizableReadLoop","detail":"{readStateIndex:684; appliedIndex:678; }","duration":"2.102631886s","start":"2026-06-15T19:54:51.407056Z","end":"2026-06-15T19:54:53.509688Z","steps":["trace[1686559877] 'read index received' (duration: 1.11839926s)","trace[1686559877] 'applied index is now lower than readState.Index' (duration: 984.231756ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:54:53.509748Z","caller":"traceutil/trace.go:171","msg":"trace[1200610574] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"2.099981737s","start":"2026-06-15T19:54:51.409749Z","end":"2026-06-15T19:54:53.509731Z","steps":["trace[1200610574] 'process raft request' (duration: 2.099772821s)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:53.509792Z","caller":"traceutil/trace.go:171","msg":"trace[1646837452] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"2.098106421s","start":"2026-06-15T19:54:51.411677Z","end":"2026-06-15T19:54:53.509784Z","steps":["trace[1646837452] 'process raft request' (duration: 2.097903135s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:53.509818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:51.408979Z","time spent":"2.100834562s","remote":"127.0.0.1:44190","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-15T19:54:53.509885Z","caller":"traceutil/trace.go:171","msg":"trace[582391538] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"2.09808347s","start":"2026-06-15T19:54:51.411794Z","end":"2026-06-15T19:54:53.509878Z","steps":["trace[582391538] 'process raft request' (duration: 2.097833243s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:53.509928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:51.411761Z","time spent":"2.098144192s","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:54:53.510033Z","caller":"traceutil/trace.go:171","msg":"trace[1520790774] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"2.095003527s","start":"2026-06-15T19:54:51.415022Z","end":"2026-06-15T19:54:53.510026Z","steps":["trace[1520790774] 'process raft request' (duration: 2.094636057s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:53.510077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:51.415007Z","time spent":"2.095046678s","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:54:53.510084Z","caller":"traceutil/trace.go:171","msg":"trace[1564925023] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"2.173692918s","start":"2026-06-15T19:54:51.336366Z","end":"2026-06-15T19:54:53.510059Z","steps":["trace[1564925023] 'process raft request' (duration: 1.189055801s)","trace[1564925023] 'compare' (duration: 983.33053ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:54:53.509852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:51.411667Z","time spent":"2.098147372s","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:54:53.510214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:51.336321Z","time spent":"2.173812213s","remote":"127.0.0.1:44372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:54:53.509844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:51.409732Z","time spent":"2.100066489s","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:54:53.51353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.097300094s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:54:53.513586Z","caller":"traceutil/trace.go:171","msg":"trace[77248499] range","detail":"{range_begin:/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:0; response_revision:654; }","duration":"2.097378237s","start":"2026-06-15T19:54:51.416194Z","end":"2026-06-15T19:54:53.513572Z","steps":["trace[77248499] 'agreement among raft nodes before linearized reading' (duration: 2.097252453s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:53.513619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:51.416182Z","time spent":"2.097429098s","remote":"127.0.0.1:44514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":28,"request content":"key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" "} {"level":"warn","ts":"2026-06-15T19:54:55.874251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.283372ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:54:55.874386Z","caller":"traceutil/trace.go:171","msg":"trace[1058428130] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"764.01449ms","start":"2026-06-15T19:54:55.110351Z","end":"2026-06-15T19:54:55.874366Z","steps":["trace[1058428130] 'process raft request' (duration: 111.499891ms)","trace[1058428130] 'compare' (duration: 652.086077ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:54:55.874452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:55.110341Z","time spent":"764.079791ms","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5571,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:54:55.889755Z","caller":"traceutil/trace.go:171","msg":"trace[1248262977] linearizableReadLoop","detail":"{readStateIndex:720; appliedIndex:718; }","duration":"708.258609ms","start":"2026-06-15T19:54:55.181466Z","end":"2026-06-15T19:54:55.889724Z","steps":["trace[1248262977] 'read index received' (duration: 40.391919ms)","trace[1248262977] 'applied index is now lower than readState.Index' (duration: 667.86554ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:54:55.890008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.512796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-b92pn\" ","response":"range_response_count:1 size:4884"} {"level":"info","ts":"2026-06-15T19:54:55.890083Z","caller":"traceutil/trace.go:171","msg":"trace[598066026] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-b92pn; range_end:; response_count:1; response_revision:689; }","duration":"708.646461ms","start":"2026-06-15T19:54:55.18142Z","end":"2026-06-15T19:54:55.890067Z","steps":["trace[598066026] 'agreement among raft nodes before linearized reading' (duration: 708.443965ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:55.890131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:55.181402Z","time spent":"708.717842ms","remote":"127.0.0.1:44372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":4907,"request content":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-b92pn\" "} {"level":"info","ts":"2026-06-15T19:54:55.89008Z","caller":"traceutil/trace.go:171","msg":"trace[721911399] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"778.669771ms","start":"2026-06-15T19:54:55.111194Z","end":"2026-06-15T19:54:55.889863Z","steps":["trace[721911399] 'process raft request' (duration: 778.384653ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:55.890457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:55.111179Z","time spent":"779.176045ms","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4059,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:54:55.894076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.365765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:54:55.894124Z","caller":"traceutil/trace.go:171","msg":"trace[984594470] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"211.575035ms","start":"2026-06-15T19:54:55.682532Z","end":"2026-06-15T19:54:55.894107Z","steps":["trace[984594470] 'process raft request' (duration: 211.441392ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:55.894175Z","caller":"traceutil/trace.go:171","msg":"trace[1409292938] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:692; }","duration":"612.506409ms","start":"2026-06-15T19:54:55.281653Z","end":"2026-06-15T19:54:55.89416Z","steps":["trace[1409292938] 'agreement among raft nodes before linearized reading' (duration: 612.371775ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:55.894299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:55.281632Z","time spent":"612.655433ms","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"warn","ts":"2026-06-15T19:54:55.894372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.5121ms","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-06-15T19:54:55.894436Z","caller":"traceutil/trace.go:171","msg":"trace[1244549773] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:692; }","duration":"378.606843ms","start":"2026-06-15T19:54:55.515813Z","end":"2026-06-15T19:54:55.89442Z","steps":["trace[1244549773] 'agreement among raft nodes before linearized reading' (duration: 378.450059ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:55.894483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:55.51579Z","time spent":"378.682935ms","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-15T19:54:55.894596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.671705ms","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-06-15T19:54:55.894629Z","caller":"traceutil/trace.go:171","msg":"trace[1989716398] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:692; }","duration":"378.718426ms","start":"2026-06-15T19:54:55.515901Z","end":"2026-06-15T19:54:55.89462Z","steps":["trace[1989716398] 'agreement among raft nodes before linearized reading' (duration: 378.637504ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:55.894648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:55.515894Z","time spent":"378.749497ms","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-15T19:54:55.894594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.826849ms","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-06-15T19:54:55.894724Z","caller":"traceutil/trace.go:171","msg":"trace[1882025251] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:692; }","duration":"379.1961ms","start":"2026-06-15T19:54:55.515522Z","end":"2026-06-15T19:54:55.894718Z","steps":["trace[1882025251] 'agreement among raft nodes before linearized reading' (duration: 378.879761ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:55.894742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:55.515508Z","time spent":"379.22893ms","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-15T19:54:55.894794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.570273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:54:55.894851Z","caller":"traceutil/trace.go:171","msg":"trace[1606615961] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:692; }","duration":"510.688676ms","start":"2026-06-15T19:54:55.384151Z","end":"2026-06-15T19:54:55.89484Z","steps":["trace[1606615961] 'agreement among raft nodes before linearized reading' (duration: 510.501951ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:55.894905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:55.384124Z","time spent":"510.771549ms","remote":"127.0.0.1:44166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-15T19:54:55.894321Z","caller":"traceutil/trace.go:171","msg":"trace[1450935805] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"412.344172ms","start":"2026-06-15T19:54:55.481968Z","end":"2026-06-15T19:54:55.894313Z","steps":["trace[1450935805] 'process raft request' (duration: 411.927019ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:55.895101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:55.481948Z","time spent":"413.074742ms","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-15T19:54:55.895171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.096286ms","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-06-15T19:54:55.895573Z","caller":"traceutil/trace.go:171","msg":"trace[1529210402] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:692; }","duration":"379.56688ms","start":"2026-06-15T19:54:55.515982Z","end":"2026-06-15T19:54:55.895549Z","steps":["trace[1529210402] 'agreement among raft nodes before linearized reading' (duration: 378.095208ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:54:55.89564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:54:55.515948Z","time spent":"379.676213ms","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-15T19:54:58.431189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.281554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-06-15T19:54:58.43175Z","caller":"traceutil/trace.go:171","msg":"trace[1625611432] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:735; }","duration":"149.86644ms","start":"2026-06-15T19:54:58.281822Z","end":"2026-06-15T19:54:58.431689Z","steps":["trace[1625611432] 'range keys from in-memory index tree' (duration: 148.988435ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:58.629758Z","caller":"traceutil/trace.go:171","msg":"trace[1255295764] transaction","detail":"{read_only:false; response_revision:736; number_of_response:1; }","duration":"119.957936ms","start":"2026-06-15T19:54:58.509771Z","end":"2026-06-15T19:54:58.629729Z","steps":["trace[1255295764] 'process raft request' (duration: 119.705569ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:54:59.012799Z","caller":"traceutil/trace.go:171","msg":"trace[884055086] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"101.073417ms","start":"2026-06-15T19:54:58.911693Z","end":"2026-06-15T19:54:59.012766Z","steps":["trace[884055086] 'process raft request' (duration: 100.225403ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:55:09.661004Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986423222828190957,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-15T19:55:09.705072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.598473ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-15T19:55:09.705424Z","caller":"traceutil/trace.go:171","msg":"trace[1431889901] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"646.537493ms","start":"2026-06-15T19:55:09.058871Z","end":"2026-06-15T19:55:09.705408Z","steps":["trace[1431889901] 'process raft request' (duration: 646.317298ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:55:09.705541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:55:09.058845Z","time spent":"646.629615ms","remote":"127.0.0.1:44402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:55:09.705731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.907533ms","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-06-15T19:55:09.705816Z","caller":"traceutil/trace.go:171","msg":"trace[439669543] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:822; }","duration":"545.055158ms","start":"2026-06-15T19:55:09.16074Z","end":"2026-06-15T19:55:09.705795Z","steps":["trace[439669543] 'agreement among raft nodes before linearized reading' (duration: 544.839432ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:55:09.705865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:55:09.160707Z","time spent":"545.149209ms","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-15T19:55:09.70599Z","caller":"traceutil/trace.go:171","msg":"trace[986488839] linearizableReadLoop","detail":"{readStateIndex:858; appliedIndex:856; }","duration":"544.539675ms","start":"2026-06-15T19:55:09.160817Z","end":"2026-06-15T19:55:09.705357Z","steps":["trace[986488839] 'read index received' (duration: 542.798971ms)","trace[986488839] 'applied index is now lower than readState.Index' (duration: 1.739774ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:55:09.706298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.158612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-15T19:55:09.706373Z","caller":"traceutil/trace.go:171","msg":"trace[1487950412] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:822; }","duration":"472.284065ms","start":"2026-06-15T19:55:09.234078Z","end":"2026-06-15T19:55:09.706362Z","steps":["trace[1487950412] 'agreement among raft nodes before linearized reading' (duration: 472.062279ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:55:09.706418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:55:09.234053Z","time spent":"472.353996ms","remote":"127.0.0.1:44378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":2,"response size":30,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-06-15T19:55:09.706375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.917382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:55:09.707249Z","caller":"traceutil/trace.go:171","msg":"trace[1969923879] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:822; }","duration":"321.835715ms","start":"2026-06-15T19:55:09.385394Z","end":"2026-06-15T19:55:09.707229Z","steps":["trace[1969923879] 'agreement among raft nodes before linearized reading' (duration: 320.903482ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:55:09.707296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:55:09.38537Z","time spent":"321.911168ms","remote":"127.0.0.1:44158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-15T19:55:24.433099Z","caller":"traceutil/trace.go:171","msg":"trace[1265354751] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"241.243678ms","start":"2026-06-15T19:55:24.191826Z","end":"2026-06-15T19:55:24.433069Z","steps":["trace[1265354751] 'process raft request' (duration: 241.091875ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:55:24.433154Z","caller":"traceutil/trace.go:171","msg":"trace[506697998] linearizableReadLoop","detail":"{readStateIndex:1030; appliedIndex:1030; }","duration":"224.526798ms","start":"2026-06-15T19:55:24.208581Z","end":"2026-06-15T19:55:24.433107Z","steps":["trace[506697998] 'read index received' (duration: 224.503278ms)","trace[506697998] 'applied index is now lower than readState.Index' (duration: 19.48µs)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:55:24.433542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.914926ms","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-06-15T19:55:24.433622Z","caller":"traceutil/trace.go:171","msg":"trace[113575566] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:991; }","duration":"225.029878ms","start":"2026-06-15T19:55:24.208552Z","end":"2026-06-15T19:55:24.433582Z","steps":["trace[113575566] 'agreement among raft nodes before linearized reading' (duration: 224.705501ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:55:24.510504Z","caller":"traceutil/trace.go:171","msg":"trace[446429605] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"243.334425ms","start":"2026-06-15T19:55:24.26714Z","end":"2026-06-15T19:55:24.510474Z","steps":["trace[446429605] 'process raft request' (duration: 176.083344ms)","trace[446429605] 'compare' (duration: 67.046615ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:55:34.644939Z","caller":"traceutil/trace.go:171","msg":"trace[1232290336] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"104.527845ms","start":"2026-06-15T19:55:34.540391Z","end":"2026-06-15T19:55:34.644918Z","steps":["trace[1232290336] 'process raft request' (duration: 67.912653ms)","trace[1232290336] 'compare' (duration: 36.319096ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:55:34.789094Z","caller":"traceutil/trace.go:171","msg":"trace[545377260] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"141.907713ms","start":"2026-06-15T19:55:34.647159Z","end":"2026-06-15T19:55:34.789066Z","steps":["trace[545377260] 'process raft request' (duration: 105.040586ms)","trace[545377260] 'compare' (duration: 36.259693ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:55:34.792515Z","caller":"traceutil/trace.go:171","msg":"trace[1396957730] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"143.912443ms","start":"2026-06-15T19:55:34.648582Z","end":"2026-06-15T19:55:34.792494Z","steps":["trace[1396957730] 'process raft request' (duration: 140.442312ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:55:46.937214Z","caller":"traceutil/trace.go:171","msg":"trace[774393123] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"131.554651ms","start":"2026-06-15T19:55:46.805622Z","end":"2026-06-15T19:55:46.937176Z","steps":["trace[774393123] 'process raft request' (duration: 131.308267ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:55:52.399673Z","caller":"traceutil/trace.go:171","msg":"trace[1252801535] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"222.953873ms","start":"2026-06-15T19:55:52.176686Z","end":"2026-06-15T19:55:52.39964Z","steps":["trace[1252801535] 'process raft request' (duration: 222.763649ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:56:24.718144Z","caller":"traceutil/trace.go:171","msg":"trace[553596344] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"104.089438ms","start":"2026-06-15T19:56:24.614022Z","end":"2026-06-15T19:56:24.718112Z","steps":["trace[553596344] 'process raft request' (duration: 103.811334ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:56:27.560024Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986423222828191823,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-15T19:56:27.713721Z","caller":"traceutil/trace.go:171","msg":"trace[1270139792] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"797.570715ms","start":"2026-06-15T19:56:26.915902Z","end":"2026-06-15T19:56:27.713473Z","steps":["trace[1270139792] 'process raft request' (duration: 796.682992ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:56:27.71393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:56:26.915871Z","time spent":"797.949471ms","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:56:27.934671Z","caller":"traceutil/trace.go:171","msg":"trace[1422253649] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"687.300947ms","start":"2026-06-15T19:56:27.247361Z","end":"2026-06-15T19:56:27.934662Z","steps":["trace[1422253649] 'process raft request' (duration: 612.409539ms)","trace[1422253649] 'compare' (duration: 74.558873ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:56:27.934791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:56:27.247339Z","time spent":"687.391979ms","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:56:27.934634Z","caller":"traceutil/trace.go:171","msg":"trace[1977743186] linearizableReadLoop","detail":"{readStateIndex:1264; appliedIndex:1262; }","duration":"874.645729ms","start":"2026-06-15T19:56:27.059946Z","end":"2026-06-15T19:56:27.934592Z","steps":["trace[1977743186] 'read index received' (duration: 652.562656ms)","trace[1977743186] 'applied index is now lower than readState.Index' (duration: 222.082303ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:56:27.935072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"875.139196ms","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-06-15T19:56:27.935093Z","caller":"traceutil/trace.go:171","msg":"trace[477953750] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1212; }","duration":"875.205988ms","start":"2026-06-15T19:56:27.059881Z","end":"2026-06-15T19:56:27.935087Z","steps":["trace[477953750] 'agreement among raft nodes before linearized reading' (duration: 875.127636ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:56:27.935114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:56:27.059853Z","time spent":"875.257718ms","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-15T19:56:27.935325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"833.668871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T19:56:27.935374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.265277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-15T19:56:27.935407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.95105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:56:27.935409Z","caller":"traceutil/trace.go:171","msg":"trace[31672393] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1212; }","duration":"833.793154ms","start":"2026-06-15T19:56:27.101592Z","end":"2026-06-15T19:56:27.935386Z","steps":["trace[31672393] 'agreement among raft nodes before linearized reading' (duration: 833.642742ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:56:27.93543Z","caller":"traceutil/trace.go:171","msg":"trace[944329284] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1212; }","duration":"207.98968ms","start":"2026-06-15T19:56:27.727435Z","end":"2026-06-15T19:56:27.935425Z","steps":["trace[944329284] 'agreement among raft nodes before linearized reading' (duration: 207.9525ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:56:27.935429Z","caller":"traceutil/trace.go:171","msg":"trace[2080400057] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1212; }","duration":"244.357408ms","start":"2026-06-15T19:56:27.691055Z","end":"2026-06-15T19:56:27.935412Z","steps":["trace[2080400057] 'agreement among raft nodes before linearized reading' (duration: 244.241077ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:56:27.935446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:56:27.101579Z","time spent":"833.858625ms","remote":"127.0.0.1:33798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-06-15T19:56:27.93564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.816813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-15T19:56:27.935664Z","caller":"traceutil/trace.go:171","msg":"trace[1804074501] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1212; }","duration":"560.881444ms","start":"2026-06-15T19:56:27.374777Z","end":"2026-06-15T19:56:27.935659Z","steps":["trace[1804074501] 'agreement among raft nodes before linearized reading' (duration: 560.795413ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:56:27.935679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:56:27.374756Z","time spent":"560.918724ms","remote":"127.0.0.1:44434","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-06-15T19:56:27.93564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.758136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:56:27.935962Z","caller":"traceutil/trace.go:171","msg":"trace[1867999963] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1212; }","duration":"467.161133ms","start":"2026-06-15T19:56:27.468779Z","end":"2026-06-15T19:56:27.935941Z","steps":["trace[1867999963] 'agreement among raft nodes before linearized reading' (duration: 466.767816ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:56:27.936085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:56:27.468757Z","time spent":"467.310535ms","remote":"127.0.0.1:33964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"info","ts":"2026-06-15T19:56:28.105428Z","caller":"traceutil/trace.go:171","msg":"trace[836411673] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"165.87334ms","start":"2026-06-15T19:56:27.93953Z","end":"2026-06-15T19:56:28.105404Z","steps":["trace[836411673] 'process raft request' (duration: 165.18764ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:56:30.275906Z","caller":"traceutil/trace.go:171","msg":"trace[266644029] linearizableReadLoop","detail":"{readStateIndex:1272; appliedIndex:1271; }","duration":"111.523247ms","start":"2026-06-15T19:56:30.164363Z","end":"2026-06-15T19:56:30.275886Z","steps":["trace[266644029] 'read index received' (duration: 110.917028ms)","trace[266644029] 'applied index is now lower than readState.Index' (duration: 604.949µs)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:56:30.276089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.70478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:56:30.276129Z","caller":"traceutil/trace.go:171","msg":"trace[71969806] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1220; }","duration":"111.786811ms","start":"2026-06-15T19:56:30.164331Z","end":"2026-06-15T19:56:30.276118Z","steps":["trace[71969806] 'agreement among raft nodes before linearized reading' (duration: 111.638769ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:56:30.276328Z","caller":"traceutil/trace.go:171","msg":"trace[1698261877] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"164.542365ms","start":"2026-06-15T19:56:30.111772Z","end":"2026-06-15T19:56:30.276314Z","steps":["trace[1698261877] 'process raft request' (duration: 163.569901ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:56:38.202483Z","caller":"traceutil/trace.go:171","msg":"trace[265750067] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"108.834675ms","start":"2026-06-15T19:56:38.093625Z","end":"2026-06-15T19:56:38.202459Z","steps":["trace[265750067] 'process raft request' (duration: 108.690403ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:56:38.427093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.379268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-15T19:56:38.427174Z","caller":"traceutil/trace.go:171","msg":"trace[599653017] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1246; }","duration":"119.496389ms","start":"2026-06-15T19:56:38.307659Z","end":"2026-06-15T19:56:38.427155Z","steps":["trace[599653017] 'range keys from in-memory index tree' (duration: 119.175074ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:56:39.097445Z","caller":"traceutil/trace.go:171","msg":"trace[1845376081] linearizableReadLoop","detail":"{readStateIndex:1302; appliedIndex:1301; }","duration":"171.808707ms","start":"2026-06-15T19:56:38.925609Z","end":"2026-06-15T19:56:39.097418Z","steps":["trace[1845376081] 'read index received' (duration: 171.567053ms)","trace[1845376081] 'applied index is now lower than readState.Index' (duration: 240.484µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:56:39.097552Z","caller":"traceutil/trace.go:171","msg":"trace[329584614] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"195.774932ms","start":"2026-06-15T19:56:38.901766Z","end":"2026-06-15T19:56:39.097541Z","steps":["trace[329584614] 'process raft request' (duration: 195.488868ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:56:39.179869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.239988ms","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-06-15T19:56:39.179933Z","caller":"traceutil/trace.go:171","msg":"trace[737164524] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1248; }","duration":"254.35443ms","start":"2026-06-15T19:56:38.925564Z","end":"2026-06-15T19:56:39.179919Z","steps":["trace[737164524] 'agreement among raft nodes before linearized reading' (duration: 171.95706ms)","trace[737164524] 'range keys from in-memory index tree' (duration: 82.229078ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:56:41.447114Z","caller":"traceutil/trace.go:171","msg":"trace[1194446161] linearizableReadLoop","detail":"{readStateIndex:1310; appliedIndex:1309; }","duration":"245.438942ms","start":"2026-06-15T19:56:41.201645Z","end":"2026-06-15T19:56:41.447084Z","steps":["trace[1194446161] 'read index received' (duration: 245.183008ms)","trace[1194446161] 'applied index is now lower than readState.Index' (duration: 254.644µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:56:41.447278Z","caller":"traceutil/trace.go:171","msg":"trace[1273105945] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"329.01629ms","start":"2026-06-15T19:56:41.118245Z","end":"2026-06-15T19:56:41.447262Z","steps":["trace[1273105945] 'process raft request' (duration: 328.624845ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:56:41.447507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:56:41.118217Z","time spent":"329.098761ms","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:56:41.447561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.895468ms","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-06-15T19:56:41.447652Z","caller":"traceutil/trace.go:171","msg":"trace[1942980131] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1255; }","duration":"246.00665ms","start":"2026-06-15T19:56:41.201625Z","end":"2026-06-15T19:56:41.447631Z","steps":["trace[1942980131] 'agreement among raft nodes before linearized reading' (duration: 245.750896ms)"],"step_count":1}