{"level":"warn","ts":"2026-05-31T17:21:45.128089Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-31T17:21:45.128169Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.72: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.72:2380","--initial-cluster=instance=https://199.204.45.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.72:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-31T17:21:45.128368Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-31T17:21:45.12838Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-05-31T17:21:45.1284Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-31T17:21:45.129339Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"]} {"level":"info","ts":"2026-05-31T17:21:45.129521Z","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.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.72:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-31T17:21:45.134339Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.445456ms"} {"level":"info","ts":"2026-05-31T17:21:45.14074Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"50e03cebfd94cbba","cluster-id":"120c03c1d5b80f94"} {"level":"info","ts":"2026-05-31T17:21:45.140899Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=()"} {"level":"info","ts":"2026-05-31T17:21:45.140927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 0"} {"level":"info","ts":"2026-05-31T17:21:45.140952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 50e03cebfd94cbba [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-31T17:21:45.140962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 1"} {"level":"info","ts":"2026-05-31T17:21:45.141002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"warn","ts":"2026-05-31T17:21:45.148852Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-31T17:21:45.150165Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-31T17:21:45.151631Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-31T17:21:45.154268Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"50e03cebfd94cbba","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-31T17:21:45.154359Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"50e03cebfd94cbba","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-31T17:21:45.154547Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-31T17:21:45.154605Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-31T17:21:45.154616Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-31T17:21:45.158324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"info","ts":"2026-05-31T17:21:45.158471Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","added-peer-id":"50e03cebfd94cbba","added-peer-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-05-31T17:21:45.159433Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-31T17:21:45.15963Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"50e03cebfd94cbba","initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-31T17:21:45.159658Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-31T17:21:45.159752Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-05-31T17:21:45.159764Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-05-31T17:21:45.941619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba is starting a new election at term 1"} {"level":"info","ts":"2026-05-31T17:21:45.941696Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became pre-candidate at term 1"} {"level":"info","ts":"2026-05-31T17:21:45.941759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgPreVoteResp from 50e03cebfd94cbba at term 1"} {"level":"info","ts":"2026-05-31T17:21:45.941804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became candidate at term 2"} {"level":"info","ts":"2026-05-31T17:21:45.941822Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgVoteResp from 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-05-31T17:21:45.941843Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became leader at term 2"} {"level":"info","ts":"2026-05-31T17:21:45.94187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 50e03cebfd94cbba elected leader 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-05-31T17:21:45.942989Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"50e03cebfd94cbba","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.72:2379]}","request-path":"/0/members/50e03cebfd94cbba/attributes","cluster-id":"120c03c1d5b80f94","publish-timeout":"7s"} {"level":"info","ts":"2026-05-31T17:21:45.943083Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-31T17:21:45.943195Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-31T17:21:45.943266Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-31T17:21:45.944132Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","cluster-version":"3.5"} {"level":"info","ts":"2026-05-31T17:21:45.944261Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-31T17:21:45.9443Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-31T17:21:45.946785Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.72:2379"} {"level":"info","ts":"2026-05-31T17:21:45.946966Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-31T17:21:45.947308Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-31T17:21:45.947332Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-31T17:21:47.624495Z","caller":"traceutil/trace.go:171","msg":"trace[2044028244] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"427.549435ms","start":"2026-05-31T17:21:47.19692Z","end":"2026-05-31T17:21:47.62447Z","steps":["trace[2044028244] 'read index received' (duration: 427.314809ms)","trace[2044028244] 'applied index is now lower than readState.Index' (duration: 233.346µs)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:21:47.624554Z","caller":"traceutil/trace.go:171","msg":"trace[1105401999] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"427.712019ms","start":"2026-05-31T17:21:47.196802Z","end":"2026-05-31T17:21:47.624514Z","steps":["trace[1105401999] 'process raft request' (duration: 427.427722ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:47.624833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.860872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-31T17:21:47.624939Z","caller":"traceutil/trace.go:171","msg":"trace[1439658953] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:2; }","duration":"428.027647ms","start":"2026-05-31T17:21:47.196891Z","end":"2026-05-31T17:21:47.624918Z","steps":["trace[1439658953] 'agreement among raft nodes before linearized reading' (duration: 427.704799ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:47.624985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:47.196877Z","time spent":"428.098348ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":26,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-31T17:21:47.62559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:47.196787Z","time spent":"427.873683ms","remote":"127.0.0.1:60546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-31T17:21:48.125188Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220203905758592,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-31T17:21:48.625908Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220203905758592,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-31T17:21:48.94722Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.323288348s","expected-duration":"1s"} {"level":"info","ts":"2026-05-31T17:21:48.948204Z","caller":"traceutil/trace.go:171","msg":"trace[2087584069] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"1.671007541s","start":"2026-05-31T17:21:47.277132Z","end":"2026-05-31T17:21:48.948139Z","steps":["trace[2087584069] 'process raft request' (duration: 1.670852628s)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:21:48.948231Z","caller":"traceutil/trace.go:171","msg":"trace[69482796] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"1.671165125s","start":"2026-05-31T17:21:47.27693Z","end":"2026-05-31T17:21:48.948095Z","steps":["trace[69482796] 'process raft request' (duration: 1.670689124s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:48.948293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:47.277119Z","time spent":"1.671128875s","remote":"127.0.0.1:60988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-31T17:21:48.948419Z","caller":"traceutil/trace.go:171","msg":"trace[1781603509] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"1.671145935s","start":"2026-05-31T17:21:47.277267Z","end":"2026-05-31T17:21:48.948413Z","steps":["trace[1781603509] 'process raft request' (duration: 1.670789576s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:48.948448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:47.277228Z","time spent":"1.671206086s","remote":"127.0.0.1:60988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-31T17:21:48.948419Z","caller":"traceutil/trace.go:171","msg":"trace[1094196981] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"1.671203926s","start":"2026-05-31T17:21:47.277184Z","end":"2026-05-31T17:21:48.948388Z","steps":["trace[1094196981] 'process raft request' (duration: 1.670844218s)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:21:48.948588Z","caller":"traceutil/trace.go:171","msg":"trace[1172594455] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"1.671040413s","start":"2026-05-31T17:21:47.277542Z","end":"2026-05-31T17:21:48.948583Z","steps":["trace[1172594455] 'process raft request' (duration: 1.670776837s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:48.94862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:47.277529Z","time spent":"1.671076143s","remote":"127.0.0.1:60988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-31T17:21:48.948671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:47.276964Z","time spent":"1.671614396s","remote":"127.0.0.1:60988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-31T17:21:48.948762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.620463362s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-31T17:21:48.948781Z","caller":"traceutil/trace.go:171","msg":"trace[741303739] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.620503133s","start":"2026-05-31T17:21:47.328273Z","end":"2026-05-31T17:21:48.948776Z","steps":["trace[741303739] 'agreement among raft nodes before linearized reading' (duration: 1.62041193s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:48.94849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:47.276908Z","time spent":"1.671480803s","remote":"127.0.0.1:60988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-31T17:21:48.949423Z","caller":"traceutil/trace.go:171","msg":"trace[398635100] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"1.670965851s","start":"2026-05-31T17:21:47.277838Z","end":"2026-05-31T17:21:48.948804Z","steps":["trace[398635100] 'process raft request' (duration: 1.670569772s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:48.949495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:47.277829Z","time spent":"1.671628817s","remote":"127.0.0.1:60918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-31T17:21:48.949512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.751854207s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-31T17:21:48.94963Z","caller":"traceutil/trace.go:171","msg":"trace[607159653] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:10; }","duration":"1.752627886s","start":"2026-05-31T17:21:47.196963Z","end":"2026-05-31T17:21:48.949591Z","steps":["trace[607159653] 'agreement among raft nodes before linearized reading' (duration: 1.751845977s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:48.949691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:47.196959Z","time spent":"1.752715268s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":26,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-31T17:21:48.949974Z","caller":"traceutil/trace.go:171","msg":"trace[1032405221] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"1.664890636s","start":"2026-05-31T17:21:47.285051Z","end":"2026-05-31T17:21:48.949942Z","steps":["trace[1032405221] 'process raft request' (duration: 1.663449061s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:48.95002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:47.285042Z","time spent":"1.664955027s","remote":"127.0.0.1:60664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-31T17:21:48.950448Z","caller":"traceutil/trace.go:171","msg":"trace[821954658] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"1.656605927s","start":"2026-05-31T17:21:47.293783Z","end":"2026-05-31T17:21:48.950389Z","steps":["trace[821954658] 'process raft request' (duration: 1.654819574s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:48.950488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:47.293767Z","time spent":"1.656706229s","remote":"127.0.0.1:60722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-31T17:21:48.95088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.74193795s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-31T17:21:48.95095Z","caller":"traceutil/trace.go:171","msg":"trace[992143560] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:10; }","duration":"1.742009332s","start":"2026-05-31T17:21:47.208911Z","end":"2026-05-31T17:21:48.95092Z","steps":["trace[992143560] 'agreement among raft nodes before linearized reading' (duration: 1.74025832s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:48.95097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.752955704s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-31T17:21:48.950989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:47.208902Z","time spent":"1.742078323s","remote":"127.0.0.1:60852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-05-31T17:21:48.95102Z","caller":"traceutil/trace.go:171","msg":"trace[1320978328] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:0; response_revision:10; }","duration":"1.753008515s","start":"2026-05-31T17:21:47.197988Z","end":"2026-05-31T17:21:48.950997Z","steps":["trace[1320978328] 'agreement among raft nodes before linearized reading' (duration: 1.752649166s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:48.951048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:47.197981Z","time spent":"1.753057936s","remote":"127.0.0.1:60534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-05-31T17:21:48.951058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.677390865s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-31T17:21:48.951101Z","caller":"traceutil/trace.go:171","msg":"trace[944406460] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:0; response_revision:10; }","duration":"1.677459016s","start":"2026-05-31T17:21:47.273625Z","end":"2026-05-31T17:21:48.951084Z","steps":["trace[944406460] 'agreement among raft nodes before linearized reading' (duration: 1.675168331s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:48.951154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:47.273602Z","time spent":"1.677541548s","remote":"127.0.0.1:60498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":26,"request content":"key:\"/registry/masterleases/199.204.45.72\" "} {"level":"warn","ts":"2026-05-31T17:21:48.951574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.67592861s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-31T17:21:48.948794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:47.328263Z","time spent":"1.620528944s","remote":"127.0.0.1:60596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-31T17:21:48.951682Z","caller":"traceutil/trace.go:171","msg":"trace[1649956799] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.676053952s","start":"2026-05-31T17:21:47.275592Z","end":"2026-05-31T17:21:48.951646Z","steps":["trace[1649956799] 'agreement among raft nodes before linearized reading' (duration: 1.675552s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:48.951735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:47.275579Z","time spent":"1.676140925s","remote":"127.0.0.1:60596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-31T17:21:48.952041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.700282963s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-31T17:21:48.952097Z","caller":"traceutil/trace.go:171","msg":"trace[1972725112] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.700314943s","start":"2026-05-31T17:21:47.25175Z","end":"2026-05-31T17:21:48.952065Z","steps":["trace[1972725112] 'agreement among raft nodes before linearized reading' (duration: 1.700272612s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:48.952119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:47.251676Z","time spent":"1.700438307s","remote":"127.0.0.1:60596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-31T17:21:48.952199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.673100123s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-31T17:21:48.952234Z","caller":"traceutil/trace.go:171","msg":"trace[1014851121] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"1.673197384s","start":"2026-05-31T17:21:47.279029Z","end":"2026-05-31T17:21:48.952226Z","steps":["trace[1014851121] 'agreement among raft nodes before linearized reading' (duration: 1.669794923s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:48.952262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:47.279019Z","time spent":"1.673233175s","remote":"127.0.0.1:60566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-05-31T17:21:48.948727Z","caller":"traceutil/trace.go:171","msg":"trace[813095331] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:5; }","duration":"1.324091227s","start":"2026-05-31T17:21:47.624585Z","end":"2026-05-31T17:21:48.948676Z","steps":["trace[813095331] 'read index received' (duration: 1.32296731s)","trace[813095331] 'applied index is now lower than readState.Index' (duration: 1.122407ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T17:21:48.9529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.271434536s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-31T17:21:48.952929Z","caller":"traceutil/trace.go:171","msg":"trace[1551339144] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.271458358s","start":"2026-05-31T17:21:47.681459Z","end":"2026-05-31T17:21:48.952917Z","steps":["trace[1551339144] 'agreement among raft nodes before linearized reading' (duration: 1.271288524s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:48.952979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:47.681397Z","time spent":"1.27156861s","remote":"127.0.0.1:60596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-31T17:21:48.953945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.133788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-31T17:21:48.953979Z","caller":"traceutil/trace.go:171","msg":"trace[458990147] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:10; }","duration":"679.181989ms","start":"2026-05-31T17:21:48.274782Z","end":"2026-05-31T17:21:48.953964Z","steps":["trace[458990147] 'agreement among raft nodes before linearized reading' (duration: 679.140858ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:48.953997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:48.274768Z","time spent":"679.224581ms","remote":"127.0.0.1:60480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-31T17:21:48.95422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"780.529396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-31T17:21:48.954251Z","caller":"traceutil/trace.go:171","msg":"trace[460333248] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:10; }","duration":"780.583126ms","start":"2026-05-31T17:21:48.173656Z","end":"2026-05-31T17:21:48.954239Z","steps":["trace[460333248] 'agreement among raft nodes before linearized reading' (duration: 780.542546ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:48.954283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:48.17364Z","time spent":"780.638318ms","remote":"127.0.0.1:60814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-05-31T17:21:48.954221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"780.30561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-31T17:21:48.95658Z","caller":"traceutil/trace.go:171","msg":"trace[1029871632] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:10; }","duration":"782.711088ms","start":"2026-05-31T17:21:48.173842Z","end":"2026-05-31T17:21:48.956553Z","steps":["trace[1029871632] 'agreement among raft nodes before linearized reading' (duration: 780.341531ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:48.956649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:48.17381Z","time spent":"782.83102ms","remote":"127.0.0.1:60818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":26,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"warn","ts":"2026-05-31T17:21:49.398163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.666367ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-05-31T17:21:49.398326Z","caller":"traceutil/trace.go:171","msg":"trace[387312805] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"444.183252ms","start":"2026-05-31T17:21:48.954118Z","end":"2026-05-31T17:21:49.398301Z","steps":["trace[387312805] 'process raft request' (duration: 209.057104ms)","trace[387312805] 'compare' (duration: 234.482843ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:21:49.399138Z","caller":"traceutil/trace.go:171","msg":"trace[1116976332] linearizableReadLoop","detail":"{readStateIndex:17; appliedIndex:13; }","duration":"442.85443ms","start":"2026-05-31T17:21:48.956255Z","end":"2026-05-31T17:21:49.399109Z","steps":["trace[1116976332] 'read index received' (duration: 206.976724ms)","trace[1116976332] 'applied index is now lower than readState.Index' (duration: 235.876726ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T17:21:49.399383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.108956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-31T17:21:49.399402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:48.954079Z","time spent":"445.210627ms","remote":"127.0.0.1:60534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-31T17:21:49.399432Z","caller":"traceutil/trace.go:171","msg":"trace[2139779858] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21; }","duration":"443.184719ms","start":"2026-05-31T17:21:48.956236Z","end":"2026-05-31T17:21:49.39942Z","steps":["trace[2139779858] 'agreement among raft nodes before linearized reading' (duration: 442.987044ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:49.399542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:48.956221Z","time spent":"443.309912ms","remote":"127.0.0.1:60478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-31T17:21:49.399881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.164754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-xmtbj\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-05-31T17:21:49.399913Z","caller":"traceutil/trace.go:171","msg":"trace[1599535448] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-xmtbj; range_end:; response_count:1; response_revision:21; }","duration":"442.227025ms","start":"2026-05-31T17:21:48.957677Z","end":"2026-05-31T17:21:49.399904Z","steps":["trace[1599535448] 'agreement among raft nodes before linearized reading' (duration: 442.170734ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:49.400001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:48.95766Z","time spent":"442.299218ms","remote":"127.0.0.1:60722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":883,"request content":"key:\"/registry/certificatesigningrequests/csr-xmtbj\" "} {"level":"info","ts":"2026-05-31T17:21:49.400088Z","caller":"traceutil/trace.go:171","msg":"trace[478594648] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"442.254036ms","start":"2026-05-31T17:21:48.957811Z","end":"2026-05-31T17:21:49.400065Z","steps":["trace[478594648] 'process raft request' (duration: 441.083758ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:49.400114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.727092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-31T17:21:49.400215Z","caller":"traceutil/trace.go:171","msg":"trace[1069531327] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"444.401898ms","start":"2026-05-31T17:21:48.955805Z","end":"2026-05-31T17:21:49.400207Z","steps":["trace[1069531327] 'process raft request' (duration: 442.82512ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:21:49.400206Z","caller":"traceutil/trace.go:171","msg":"trace[490469076] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"442.154783ms","start":"2026-05-31T17:21:48.958044Z","end":"2026-05-31T17:21:49.400198Z","steps":["trace[490469076] 'process raft request' (duration: 440.918884ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:21:49.400243Z","caller":"traceutil/trace.go:171","msg":"trace[1048500939] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:21; }","duration":"240.916317ms","start":"2026-05-31T17:21:49.159302Z","end":"2026-05-31T17:21:49.400218Z","steps":["trace[1048500939] 'agreement among raft nodes before linearized reading' (duration: 240.696382ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:49.400257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:48.955791Z","time spent":"444.447268ms","remote":"127.0.0.1:60988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-31T17:21:49.400314Z","caller":"traceutil/trace.go:171","msg":"trace[839558045] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"441.013236ms","start":"2026-05-31T17:21:48.959262Z","end":"2026-05-31T17:21:49.400276Z","steps":["trace[839558045] 'process raft request' (duration: 439.765166ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:49.40033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:48.958021Z","time spent":"442.245896ms","remote":"127.0.0.1:60988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-31T17:21:49.400394Z","caller":"traceutil/trace.go:171","msg":"trace[2087166952] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"444.396478ms","start":"2026-05-31T17:21:48.955987Z","end":"2026-05-31T17:21:49.400384Z","steps":["trace[2087166952] 'process raft request' (duration: 442.761729ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:49.400441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:48.955975Z","time spent":"444.442659ms","remote":"127.0.0.1:60988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-31T17:21:49.400467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:48.959256Z","time spent":"441.128159ms","remote":"127.0.0.1:60664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3478,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-31T17:21:49.400529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.880999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-31T17:21:49.40058Z","caller":"traceutil/trace.go:171","msg":"trace[1128294209] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21; }","duration":"124.945461ms","start":"2026-05-31T17:21:49.275613Z","end":"2026-05-31T17:21:49.400558Z","steps":["trace[1128294209] 'agreement among raft nodes before linearized reading' (duration: 124.88928ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:21:49.400596Z","caller":"traceutil/trace.go:171","msg":"trace[1564223625] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"444.48862ms","start":"2026-05-31T17:21:48.956098Z","end":"2026-05-31T17:21:49.400587Z","steps":["trace[1564223625] 'process raft request' (duration: 442.683237ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:49.400673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:48.956083Z","time spent":"444.568691ms","remote":"127.0.0.1:60596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-31T17:21:49.400137Z","caller":"traceutil/trace.go:171","msg":"trace[933937799] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"442.186235ms","start":"2026-05-31T17:21:48.957937Z","end":"2026-05-31T17:21:49.400123Z","steps":["trace[933937799] 'process raft request' (duration: 441.003656ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:49.400697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.658377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-05-31T17:21:49.40076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:48.957931Z","time spent":"442.781399ms","remote":"127.0.0.1:60988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-31T17:21:49.400801Z","caller":"traceutil/trace.go:171","msg":"trace[1297813984] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"442.472692ms","start":"2026-05-31T17:21:48.958319Z","end":"2026-05-31T17:21:49.400791Z","steps":["trace[1297813984] 'process raft request' (duration: 440.670609ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:49.400844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:48.958302Z","time spent":"442.523533ms","remote":"127.0.0.1:60852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-31T17:21:49.400164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:48.957803Z","time spent":"442.329288ms","remote":"127.0.0.1:60988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-31T17:21:49.400913Z","caller":"traceutil/trace.go:171","msg":"trace[546303606] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"443.650619ms","start":"2026-05-31T17:21:48.957252Z","end":"2026-05-31T17:21:49.400902Z","steps":["trace[546303606] 'process raft request' (duration: 441.57591ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:21:49.40078Z","caller":"traceutil/trace.go:171","msg":"trace[1518792946] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:21; }","duration":"384.76574ms","start":"2026-05-31T17:21:49.016003Z","end":"2026-05-31T17:21:49.400769Z","steps":["trace[1518792946] 'agreement among raft nodes before linearized reading' (duration: 384.658418ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:21:49.401003Z","caller":"traceutil/trace.go:171","msg":"trace[1969506955] transaction","detail":"{read_only:false; number_of_response:0; response_revision:15; }","duration":"443.309222ms","start":"2026-05-31T17:21:48.957688Z","end":"2026-05-31T17:21:49.400997Z","steps":["trace[1969506955] 'process raft request' (duration: 441.178341ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:49.401043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:48.95768Z","time spent":"443.343402ms","remote":"127.0.0.1:60596","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":26,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-31T17:21:49.40105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:49.015982Z","time spent":"385.031837ms","remote":"127.0.0.1:60596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":372,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-31T17:21:49.401161Z","caller":"traceutil/trace.go:171","msg":"trace[675429954] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"441.750754ms","start":"2026-05-31T17:21:48.959403Z","end":"2026-05-31T17:21:49.401153Z","steps":["trace[675429954] 'process raft request' (duration: 439.672965ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:49.401199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:48.959397Z","time spent":"441.784155ms","remote":"127.0.0.1:60818","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-31T17:21:49.401395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.218072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-05-31T17:21:49.401427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.313458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-31T17:21:49.400973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:48.957243Z","time spent":"443.697181ms","remote":"127.0.0.1:60918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-31T17:21:49.401463Z","caller":"traceutil/trace.go:171","msg":"trace[119861253] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:21; }","duration":"442.350149ms","start":"2026-05-31T17:21:48.959102Z","end":"2026-05-31T17:21:49.401452Z","steps":["trace[119861253] 'agreement among raft nodes before linearized reading' (duration: 442.295267ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:49.40152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:48.959089Z","time spent":"442.396779ms","remote":"127.0.0.1:60816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":26,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" "} {"level":"info","ts":"2026-05-31T17:21:49.401439Z","caller":"traceutil/trace.go:171","msg":"trace[1461377358] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:21; }","duration":"393.288644ms","start":"2026-05-31T17:21:49.008139Z","end":"2026-05-31T17:21:49.401427Z","steps":["trace[1461377358] 'agreement among raft nodes before linearized reading' (duration: 393.195592ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:49.401679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:21:49.008123Z","time spent":"393.543431ms","remote":"127.0.0.1:60596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":372,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-31T17:21:56.33609Z","caller":"traceutil/trace.go:171","msg":"trace[1209825646] linearizableReadLoop","detail":"{readStateIndex:318; appliedIndex:316; }","duration":"190.608283ms","start":"2026-05-31T17:21:56.14546Z","end":"2026-05-31T17:21:56.336069Z","steps":["trace[1209825646] 'read index received' (duration: 6.732451ms)","trace[1209825646] 'applied index is now lower than readState.Index' (duration: 183.874992ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:21:56.336208Z","caller":"traceutil/trace.go:171","msg":"trace[1995473073] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"198.363149ms","start":"2026-05-31T17:21:56.1378Z","end":"2026-05-31T17:21:56.336163Z","steps":["trace[1995473073] 'process raft request' (duration: 198.138674ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:56.336324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.841958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-31T17:21:56.336458Z","caller":"traceutil/trace.go:171","msg":"trace[1716487256] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:305; }","duration":"190.982662ms","start":"2026-05-31T17:21:56.145449Z","end":"2026-05-31T17:21:56.336432Z","steps":["trace[1716487256] 'agreement among raft nodes before linearized reading' (duration: 190.771537ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:21:56.336518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.531628ms","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-05-31T17:21:56.336634Z","caller":"traceutil/trace.go:171","msg":"trace[1311811536] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:305; }","duration":"141.735263ms","start":"2026-05-31T17:21:56.194877Z","end":"2026-05-31T17:21:56.336612Z","steps":["trace[1311811536] 'agreement among raft nodes before linearized reading' (duration: 141.405425ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:21:56.53348Z","caller":"traceutil/trace.go:171","msg":"trace[723861066] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"104.43ms","start":"2026-05-31T17:21:56.429025Z","end":"2026-05-31T17:21:56.533455Z","steps":["trace[723861066] 'process raft request' (duration: 51.600745ms)","trace[723861066] 'compare' (duration: 52.62588ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:21:56.533502Z","caller":"traceutil/trace.go:171","msg":"trace[1705077706] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"103.748043ms","start":"2026-05-31T17:21:56.429733Z","end":"2026-05-31T17:21:56.533481Z","steps":["trace[1705077706] 'process raft request' (duration: 103.658401ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:21:56.533651Z","caller":"traceutil/trace.go:171","msg":"trace[1277523399] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"103.838016ms","start":"2026-05-31T17:21:56.429796Z","end":"2026-05-31T17:21:56.533634Z","steps":["trace[1277523399] 'process raft request' (duration: 103.637601ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:21:56.533659Z","caller":"traceutil/trace.go:171","msg":"trace[776010881] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"103.765384ms","start":"2026-05-31T17:21:56.429865Z","end":"2026-05-31T17:21:56.533631Z","steps":["trace[776010881] 'process raft request' (duration: 103.6078ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:21:56.533803Z","caller":"traceutil/trace.go:171","msg":"trace[1237155756] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"100.411124ms","start":"2026-05-31T17:21:56.433381Z","end":"2026-05-31T17:21:56.533792Z","steps":["trace[1237155756] 'process raft request' (duration: 100.201879ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:21:56.533921Z","caller":"traceutil/trace.go:171","msg":"trace[1115213307] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"102.453282ms","start":"2026-05-31T17:21:56.431236Z","end":"2026-05-31T17:21:56.533689Z","steps":["trace[1115213307] 'process raft request' (duration: 102.269478ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:21:56.533642Z","caller":"traceutil/trace.go:171","msg":"trace[373054866] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"100.262621ms","start":"2026-05-31T17:21:56.433354Z","end":"2026-05-31T17:21:56.533617Z","steps":["trace[373054866] 'process raft request' (duration: 100.192959ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:22:22.832441Z","caller":"traceutil/trace.go:171","msg":"trace[1638553874] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"536.620993ms","start":"2026-05-31T17:22:22.2958Z","end":"2026-05-31T17:22:22.832421Z","steps":["trace[1638553874] 'process raft request' (duration: 536.219774ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:22.832564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:22.295769Z","time spent":"536.730226ms","remote":"127.0.0.1:60572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317292,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-31T17:22:22.832636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.248586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-31T17:22:22.832727Z","caller":"traceutil/trace.go:171","msg":"trace[577222721] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:449; }","duration":"249.392679ms","start":"2026-05-31T17:22:22.583312Z","end":"2026-05-31T17:22:22.832705Z","steps":["trace[577222721] 'agreement among raft nodes before linearized reading' (duration: 249.201745ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:22:22.832373Z","caller":"traceutil/trace.go:171","msg":"trace[160535603] linearizableReadLoop","detail":"{readStateIndex:469; appliedIndex:468; }","duration":"248.98572ms","start":"2026-05-31T17:22:22.583368Z","end":"2026-05-31T17:22:22.832354Z","steps":["trace[160535603] 'read index received' (duration: 248.099418ms)","trace[160535603] 'applied index is now lower than readState.Index' (duration: 885.102µs)"],"step_count":2} {"level":"warn","ts":"2026-05-31T17:22:22.854528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.815157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-31T17:22:22.854571Z","caller":"traceutil/trace.go:171","msg":"trace[1384602884] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"204.76482ms","start":"2026-05-31T17:22:22.649756Z","end":"2026-05-31T17:22:22.854521Z","steps":["trace[1384602884] 'process raft request' (duration: 204.564325ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:22:22.854608Z","caller":"traceutil/trace.go:171","msg":"trace[1912839740] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:450; }","duration":"251.94614ms","start":"2026-05-31T17:22:22.602644Z","end":"2026-05-31T17:22:22.85459Z","steps":["trace[1912839740] 'agreement among raft nodes before linearized reading' (duration: 251.804947ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:22:24.889861Z","caller":"traceutil/trace.go:171","msg":"trace[1094479541] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"373.013879ms","start":"2026-05-31T17:22:24.51682Z","end":"2026-05-31T17:22:24.889833Z","steps":["trace[1094479541] 'process raft request' (duration: 372.865726ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:24.890027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:24.5168Z","time spent":"373.155983ms","remote":"127.0.0.1:60512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-31T17:22:24.899336Z","caller":"traceutil/trace.go:171","msg":"trace[1160882503] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"343.158598ms","start":"2026-05-31T17:22:24.556149Z","end":"2026-05-31T17:22:24.899307Z","steps":["trace[1160882503] 'process raft request' (duration: 342.485472ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:24.899474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:24.556138Z","time spent":"343.275461ms","remote":"127.0.0.1:60512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-31T17:22:24.899457Z","caller":"traceutil/trace.go:171","msg":"trace[1778936124] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"333.673848ms","start":"2026-05-31T17:22:24.565749Z","end":"2026-05-31T17:22:24.899423Z","steps":["trace[1778936124] 'process raft request' (duration: 332.93899ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:22:24.899624Z","caller":"traceutil/trace.go:171","msg":"trace[2055128052] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"377.664311ms","start":"2026-05-31T17:22:24.521951Z","end":"2026-05-31T17:22:24.899616Z","steps":["trace[2055128052] 'process raft request' (duration: 376.284498ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:24.899623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:24.565742Z","time spent":"333.79235ms","remote":"127.0.0.1:60512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-31T17:22:24.899658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:24.521912Z","time spent":"377.732013ms","remote":"127.0.0.1:60512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-31T17:22:24.899713Z","caller":"traceutil/trace.go:171","msg":"trace[143875326] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"370.12725ms","start":"2026-05-31T17:22:24.52958Z","end":"2026-05-31T17:22:24.899707Z","steps":["trace[143875326] 'process raft request' (duration: 368.796497ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:22:24.899729Z","caller":"traceutil/trace.go:171","msg":"trace[393381077] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"324.983158ms","start":"2026-05-31T17:22:24.574735Z","end":"2026-05-31T17:22:24.899718Z","steps":["trace[393381077] 'process raft request' (duration: 323.996494ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:24.899772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:24.574727Z","time spent":"325.022009ms","remote":"127.0.0.1:60512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-31T17:22:24.899848Z","caller":"traceutil/trace.go:171","msg":"trace[1149651457] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"312.296071ms","start":"2026-05-31T17:22:24.587543Z","end":"2026-05-31T17:22:24.899839Z","steps":["trace[1149651457] 'process raft request' (duration: 311.297827ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:24.899747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:24.529562Z","time spent":"370.16608ms","remote":"127.0.0.1:60512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-31T17:22:24.89993Z","caller":"traceutil/trace.go:171","msg":"trace[1081384054] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"195.415705ms","start":"2026-05-31T17:22:24.704504Z","end":"2026-05-31T17:22:24.89992Z","steps":["trace[1081384054] 'process raft request' (duration: 194.443871ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:22:24.90002Z","caller":"traceutil/trace.go:171","msg":"trace[903546544] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:509; }","duration":"297.718579ms","start":"2026-05-31T17:22:24.602286Z","end":"2026-05-31T17:22:24.900004Z","steps":["trace[903546544] 'read index received' (duration: 287.565534ms)","trace[903546544] 'applied index is now lower than readState.Index' (duration: 10.151195ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:22:24.900034Z","caller":"traceutil/trace.go:171","msg":"trace[608301695] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"365.429276ms","start":"2026-05-31T17:22:24.534596Z","end":"2026-05-31T17:22:24.900025Z","steps":["trace[608301695] 'process raft request' (duration: 363.822027ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:24.900105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:24.534572Z","time spent":"365.514768ms","remote":"127.0.0.1:60512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-31T17:22:24.90021Z","caller":"traceutil/trace.go:171","msg":"trace[1090131076] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"364.446342ms","start":"2026-05-31T17:22:24.535719Z","end":"2026-05-31T17:22:24.900166Z","steps":["trace[1090131076] 'process raft request' (duration: 362.74046ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:24.90025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:24.535703Z","time spent":"364.529714ms","remote":"127.0.0.1:60512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-31T17:22:24.900311Z","caller":"traceutil/trace.go:171","msg":"trace[1677698984] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"361.436879ms","start":"2026-05-31T17:22:24.538867Z","end":"2026-05-31T17:22:24.900304Z","steps":["trace[1677698984] 'process raft request' (duration: 359.638986ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:24.900336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:24.53886Z","time spent":"361.46379ms","remote":"127.0.0.1:60512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-31T17:22:24.900401Z","caller":"traceutil/trace.go:171","msg":"trace[1233346022] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"361.48543ms","start":"2026-05-31T17:22:24.538907Z","end":"2026-05-31T17:22:24.900393Z","steps":["trace[1233346022] 'process raft request' (duration: 359.672586ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:24.900439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:24.538902Z","time spent":"361.516941ms","remote":"127.0.0.1:60512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-31T17:22:24.900441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.142929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-31T17:22:24.899896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:24.587507Z","time spent":"312.370853ms","remote":"127.0.0.1:60512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-31T17:22:24.900494Z","caller":"traceutil/trace.go:171","msg":"trace[447130582] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:501; }","duration":"298.20525ms","start":"2026-05-31T17:22:24.602271Z","end":"2026-05-31T17:22:24.900476Z","steps":["trace[447130582] 'agreement among raft nodes before linearized reading' (duration: 298.052557ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:31.439961Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220203905759792,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-31T17:22:31.63864Z","caller":"traceutil/trace.go:171","msg":"trace[1945395991] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:608; }","duration":"699.36564ms","start":"2026-05-31T17:22:30.93925Z","end":"2026-05-31T17:22:31.638616Z","steps":["trace[1945395991] 'read index received' (duration: 698.715174ms)","trace[1945395991] 'applied index is now lower than readState.Index' (duration: 649.436µs)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:22:31.638716Z","caller":"traceutil/trace.go:171","msg":"trace[1816120557] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"883.241756ms","start":"2026-05-31T17:22:30.755434Z","end":"2026-05-31T17:22:31.638675Z","steps":["trace[1816120557] 'process raft request' (duration: 882.629401ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:31.638886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:30.755389Z","time spent":"883.39738ms","remote":"127.0.0.1:60572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036105,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-31T17:22:31.639194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.835921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-31T17:22:31.639319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.072507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-lm984\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-31T17:22:31.639387Z","caller":"traceutil/trace.go:171","msg":"trace[1577894702] range","detail":"{range_begin:/registry/pods/kube-system/cilium-lm984; range_end:; response_count:1; response_revision:585; }","duration":"700.1693ms","start":"2026-05-31T17:22:30.939203Z","end":"2026-05-31T17:22:31.639372Z","steps":["trace[1577894702] 'agreement among raft nodes before linearized reading' (duration: 699.553035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:31.639425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:30.939181Z","time spent":"700.236631ms","remote":"127.0.0.1:60672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16983,"request content":"key:\"/registry/pods/kube-system/cilium-lm984\" "} {"level":"info","ts":"2026-05-31T17:22:31.639497Z","caller":"traceutil/trace.go:171","msg":"trace[1064052063] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:585; }","duration":"695.123128ms","start":"2026-05-31T17:22:30.944239Z","end":"2026-05-31T17:22:31.639362Z","steps":["trace[1064052063] 'agreement among raft nodes before linearized reading' (duration: 694.625626ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:31.639629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:30.944215Z","time spent":"695.396665ms","remote":"127.0.0.1:60730","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-05-31T17:22:32.399445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.742829ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-31T17:22:32.39957Z","caller":"traceutil/trace.go:171","msg":"trace[857544092] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:609; }","duration":"749.80522ms","start":"2026-05-31T17:22:31.649748Z","end":"2026-05-31T17:22:32.399553Z","steps":["trace[857544092] 'read index received' (duration: 348.797474ms)","trace[857544092] 'applied index is now lower than readState.Index' (duration: 401.006686ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:22:32.399672Z","caller":"traceutil/trace.go:171","msg":"trace[1000968690] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"754.073243ms","start":"2026-05-31T17:22:31.645587Z","end":"2026-05-31T17:22:32.39966Z","steps":["trace[1000968690] 'process raft request' (duration: 353.040857ms)","trace[1000968690] 'compare' (duration: 400.645397ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T17:22:32.399729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:31.645553Z","time spent":"754.146054ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-31T17:22:32.399949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.199369ms","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-05-31T17:22:32.399981Z","caller":"traceutil/trace.go:171","msg":"trace[1489052009] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:586; }","duration":"750.263301ms","start":"2026-05-31T17:22:31.649708Z","end":"2026-05-31T17:22:32.399971Z","steps":["trace[1489052009] 'agreement among raft nodes before linearized reading' (duration: 750.199469ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:32.400009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:31.649691Z","time spent":"750.311392ms","remote":"127.0.0.1:60730","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-05-31T17:22:32.436673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"762.688391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-31T17:22:32.43681Z","caller":"traceutil/trace.go:171","msg":"trace[825891382] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:588; }","duration":"762.883716ms","start":"2026-05-31T17:22:31.673897Z","end":"2026-05-31T17:22:32.436781Z","steps":["trace[825891382] 'agreement among raft nodes before linearized reading' (duration: 762.62734ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:32.436873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:31.673848Z","time spent":"763.015589ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-31T17:22:32.43726Z","caller":"traceutil/trace.go:171","msg":"trace[2137330163] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"748.607421ms","start":"2026-05-31T17:22:31.688596Z","end":"2026-05-31T17:22:32.437203Z","steps":["trace[2137330163] 'process raft request' (duration: 747.861463ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:32.437265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.747532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-31T17:22:32.437429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:31.688576Z","time spent":"748.774985ms","remote":"127.0.0.1:60680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-31T17:22:32.437469Z","caller":"traceutil/trace.go:171","msg":"trace[601203667] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:588; }","duration":"281.988608ms","start":"2026-05-31T17:22:32.155454Z","end":"2026-05-31T17:22:32.437442Z","steps":["trace[601203667] 'agreement among raft nodes before linearized reading' (duration: 281.67239ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:22:32.43726Z","caller":"traceutil/trace.go:171","msg":"trace[170274028] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"781.938407ms","start":"2026-05-31T17:22:31.655281Z","end":"2026-05-31T17:22:32.437219Z","steps":["trace[170274028] 'process raft request' (duration: 780.982804ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:32.43764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:31.655253Z","time spent":"782.306566ms","remote":"127.0.0.1:60672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-31T17:22:33.295923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.16412ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-31T17:22:33.296391Z","caller":"traceutil/trace.go:171","msg":"trace[387785900] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:612; }","duration":"848.020066ms","start":"2026-05-31T17:22:32.448345Z","end":"2026-05-31T17:22:33.296365Z","steps":["trace[387785900] 'read index received' (duration: 1.866366ms)","trace[387785900] 'applied index is now lower than readState.Index' (duration: 846.15218ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:22:33.296523Z","caller":"traceutil/trace.go:171","msg":"trace[218614337] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"854.281806ms","start":"2026-05-31T17:22:32.442225Z","end":"2026-05-31T17:22:33.296507Z","steps":["trace[218614337] 'process raft request' (duration: 744.375379ms)","trace[218614337] 'compare' (duration: 108.658817ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:22:33.296576Z","caller":"traceutil/trace.go:171","msg":"trace[515482306] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"338.188387ms","start":"2026-05-31T17:22:32.958354Z","end":"2026-05-31T17:22:33.296542Z","steps":["trace[515482306] 'process raft request' (duration: 337.966662ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:22:33.296666Z","caller":"traceutil/trace.go:171","msg":"trace[605737744] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"854.117212ms","start":"2026-05-31T17:22:32.442518Z","end":"2026-05-31T17:22:33.296635Z","steps":["trace[605737744] 'process raft request' (duration: 853.559879ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:33.296716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"693.837607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-31T17:22:33.296603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:32.442198Z","time spent":"854.364789ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-31T17:22:33.296751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:32.958327Z","time spent":"338.334611ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-31T17:22:33.29677Z","caller":"traceutil/trace.go:171","msg":"trace[1811847701] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:592; }","duration":"693.96854ms","start":"2026-05-31T17:22:32.602785Z","end":"2026-05-31T17:22:33.296754Z","steps":["trace[1811847701] 'agreement among raft nodes before linearized reading' (duration: 693.845237ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:33.296594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"848.233661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-31T17:22:33.296809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:32.442502Z","time spent":"854.237495ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-31T17:22:33.296806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:32.602751Z","time spent":"694.047662ms","remote":"127.0.0.1:60480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-31T17:22:33.296834Z","caller":"traceutil/trace.go:171","msg":"trace[1933916523] range","detail":"{range_begin:/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:592; }","duration":"848.524978ms","start":"2026-05-31T17:22:32.448292Z","end":"2026-05-31T17:22:33.296817Z","steps":["trace[1933916523] 'agreement among raft nodes before linearized reading' (duration: 848.20936ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:33.296866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:32.448264Z","time spent":"848.59644ms","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":0,"response size":27,"request content":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-05-31T17:22:34.905014Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220203905759808,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-31T17:22:35.405854Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220203905759808,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-31T17:22:35.90629Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220203905759808,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-31T17:22:36.40661Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220203905759808,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-31T17:22:36.545344Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.83999867s","expected-duration":"1s"} {"level":"info","ts":"2026-05-31T17:22:36.547255Z","caller":"traceutil/trace.go:171","msg":"trace[30457852] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"2.846652151s","start":"2026-05-31T17:22:33.700553Z","end":"2026-05-31T17:22:36.547206Z","steps":["trace[30457852] 'process raft request' (duration: 2.845612445s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:36.547501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:33.700523Z","time spent":"2.846846795s","remote":"127.0.0.1:60572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036161,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-31T17:22:36.581894Z","caller":"traceutil/trace.go:171","msg":"trace[2097503787] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:616; }","duration":"2.177144332s","start":"2026-05-31T17:22:34.404705Z","end":"2026-05-31T17:22:36.581849Z","steps":["trace[2097503787] 'read index received' (duration: 2.140860235s)","trace[2097503787] 'applied index is now lower than readState.Index' (duration: 36.282047ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T17:22:36.582328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.177605704s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-31T17:22:36.582633Z","caller":"traceutil/trace.go:171","msg":"trace[1625068361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:593; }","duration":"2.177963462s","start":"2026-05-31T17:22:34.404652Z","end":"2026-05-31T17:22:36.582615Z","steps":["trace[1625068361] 'agreement among raft nodes before linearized reading' (duration: 2.177509511s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:36.582616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.981791099s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-31T17:22:36.58268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.281425115s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-31T17:22:36.582633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.281098327s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-31T17:22:36.58284Z","caller":"traceutil/trace.go:171","msg":"trace[1733919372] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:593; }","duration":"1.281360233s","start":"2026-05-31T17:22:35.301462Z","end":"2026-05-31T17:22:36.582822Z","steps":["trace[1733919372] 'agreement among raft nodes before linearized reading' (duration: 1.281068956s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:36.582479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.128852074s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-31T17:22:36.582938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:35.301439Z","time spent":"1.281438974s","remote":"127.0.0.1:60730","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":"info","ts":"2026-05-31T17:22:36.58299Z","caller":"traceutil/trace.go:171","msg":"trace[249577836] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:593; }","duration":"2.129369977s","start":"2026-05-31T17:22:34.453585Z","end":"2026-05-31T17:22:36.582955Z","steps":["trace[249577836] 'agreement among raft nodes before linearized reading' (duration: 2.128845044s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:36.583046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:34.453564Z","time spent":"2.12946633s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-31T17:22:36.582756Z","caller":"traceutil/trace.go:171","msg":"trace[1972397234] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:593; }","duration":"1.981941043s","start":"2026-05-31T17:22:34.600752Z","end":"2026-05-31T17:22:36.582693Z","steps":["trace[1972397234] 'agreement among raft nodes before linearized reading' (duration: 1.981756708s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:36.583142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:34.600727Z","time spent":"1.982382624s","remote":"127.0.0.1:60480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-31T17:22:36.582773Z","caller":"traceutil/trace.go:171","msg":"trace[1138005066] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:593; }","duration":"1.281554447s","start":"2026-05-31T17:22:35.301196Z","end":"2026-05-31T17:22:36.582751Z","steps":["trace[1138005066] 'agreement among raft nodes before linearized reading' (duration: 1.28124636s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:36.583352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:35.301174Z","time spent":"1.282153962s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-31T17:22:36.582705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:34.404623Z","time spent":"2.178068655s","remote":"127.0.0.1:60730","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":"info","ts":"2026-05-31T17:22:38.462208Z","caller":"traceutil/trace.go:171","msg":"trace[761616319] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"176.821295ms","start":"2026-05-31T17:22:38.285361Z","end":"2026-05-31T17:22:38.462183Z","steps":["trace[761616319] 'process raft request' (duration: 176.675052ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:22:38.465099Z","caller":"traceutil/trace.go:171","msg":"trace[1194444000] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"140.903827ms","start":"2026-05-31T17:22:38.324162Z","end":"2026-05-31T17:22:38.465066Z","steps":["trace[1194444000] 'process raft request' (duration: 140.668961ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:22:42.739781Z","caller":"traceutil/trace.go:171","msg":"trace[1584812232] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"111.349272ms","start":"2026-05-31T17:22:42.6284Z","end":"2026-05-31T17:22:42.739749Z","steps":["trace[1584812232] 'process raft request' (duration: 111.299061ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:22:42.740297Z","caller":"traceutil/trace.go:171","msg":"trace[288655406] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"112.11968ms","start":"2026-05-31T17:22:42.628163Z","end":"2026-05-31T17:22:42.740282Z","steps":["trace[288655406] 'process raft request' (duration: 111.338201ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:22:42.740466Z","caller":"traceutil/trace.go:171","msg":"trace[1337844708] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"112.046499ms","start":"2026-05-31T17:22:42.628407Z","end":"2026-05-31T17:22:42.740453Z","steps":["trace[1337844708] 'process raft request' (duration: 111.23145ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:22:50.641773Z","caller":"traceutil/trace.go:171","msg":"trace[152664994] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"299.246146ms","start":"2026-05-31T17:22:50.342071Z","end":"2026-05-31T17:22:50.641317Z","steps":["trace[152664994] 'process raft request' (duration: 298.831476ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:53.282659Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220203905760142,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-31T17:22:53.622687Z","caller":"traceutil/trace.go:171","msg":"trace[2101647582] linearizableReadLoop","detail":"{readStateIndex:798; appliedIndex:797; }","duration":"840.323839ms","start":"2026-05-31T17:22:52.782343Z","end":"2026-05-31T17:22:53.622667Z","steps":["trace[2101647582] 'read index received' (duration: 840.224257ms)","trace[2101647582] 'applied index is now lower than readState.Index' (duration: 98.752µs)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:22:53.622805Z","caller":"traceutil/trace.go:171","msg":"trace[1121842597] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"872.463135ms","start":"2026-05-31T17:22:52.750307Z","end":"2026-05-31T17:22:53.622771Z","steps":["trace[1121842597] 'process raft request' (duration: 872.25685ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:53.622959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:52.750266Z","time spent":"872.616799ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-31T17:22:53.623075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"840.712178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-31T17:22:53.623129Z","caller":"traceutil/trace.go:171","msg":"trace[547038797] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:768; }","duration":"840.802981ms","start":"2026-05-31T17:22:52.782316Z","end":"2026-05-31T17:22:53.623119Z","steps":["trace[547038797] 'agreement among raft nodes before linearized reading' (duration: 840.516064ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:53.623178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:52.782305Z","time spent":"840.862402ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-31T17:22:54.123587Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220203905760145,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-31T17:22:54.624451Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220203905760145,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-31T17:22:54.646084Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.019305317s","expected-duration":"1s"} {"level":"info","ts":"2026-05-31T17:22:54.647089Z","caller":"traceutil/trace.go:171","msg":"trace[1791146795] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"1.257172618s","start":"2026-05-31T17:22:53.389553Z","end":"2026-05-31T17:22:54.646726Z","steps":["trace[1791146795] 'process raft request' (duration: 1.257005174s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:54.647382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:53.389528Z","time spent":"1.257625209s","remote":"127.0.0.1:60664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4904,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-31T17:22:54.652278Z","caller":"traceutil/trace.go:171","msg":"trace[1736962905] linearizableReadLoop","detail":"{readStateIndex:801; appliedIndex:798; }","duration":"1.029445982s","start":"2026-05-31T17:22:53.622809Z","end":"2026-05-31T17:22:54.652255Z","steps":["trace[1736962905] 'read index received' (duration: 1.023619951s)","trace[1736962905] 'applied index is now lower than readState.Index' (duration: 5.824781ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T17:22:54.652473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.725042722s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-31T17:22:54.652522Z","caller":"traceutil/trace.go:171","msg":"trace[1223046550] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:771; }","duration":"1.725100053s","start":"2026-05-31T17:22:52.927402Z","end":"2026-05-31T17:22:54.652502Z","steps":["trace[1223046550] 'agreement among raft nodes before linearized reading' (duration: 1.725018181s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:54.652563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:52.927323Z","time spent":"1.725229975s","remote":"127.0.0.1:60596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":5,"response size":29,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-05-31T17:22:54.652652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.868909229s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-31T17:22:54.652638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.595651162s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-j6q86\" ","response":"range_response_count:1 size:3964"} {"level":"warn","ts":"2026-05-31T17:22:54.652823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"951.264071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-31T17:22:54.652806Z","caller":"traceutil/trace.go:171","msg":"trace[1899455101] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-j6q86; range_end:; response_count:1; response_revision:771; }","duration":"1.595910549s","start":"2026-05-31T17:22:53.056871Z","end":"2026-05-31T17:22:54.652781Z","steps":["trace[1899455101] 'agreement among raft nodes before linearized reading' (duration: 1.595450028s)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:22:54.652862Z","caller":"traceutil/trace.go:171","msg":"trace[1302064609] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:771; }","duration":"951.338583ms","start":"2026-05-31T17:22:53.701511Z","end":"2026-05-31T17:22:54.65285Z","steps":["trace[1302064609] 'agreement among raft nodes before linearized reading' (duration: 951.254421ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:54.652851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.868070299s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-31T17:22:54.652898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:53.701491Z","time spent":"951.399804ms","remote":"127.0.0.1:60816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":52,"response size":29,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"info","ts":"2026-05-31T17:22:54.652907Z","caller":"traceutil/trace.go:171","msg":"trace[930670108] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:771; }","duration":"1.868164321s","start":"2026-05-31T17:22:52.784733Z","end":"2026-05-31T17:22:54.652897Z","steps":["trace[930670108] 'agreement among raft nodes before linearized reading' (duration: 1.868031728s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:54.652889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:53.056853Z","time spent":"1.596022812s","remote":"127.0.0.1:60672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3986,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-j6q86\" "} {"level":"warn","ts":"2026-05-31T17:22:54.652973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:52.784712Z","time spent":"1.868248914s","remote":"127.0.0.1:60730","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-05-31T17:22:54.652735Z","caller":"traceutil/trace.go:171","msg":"trace[1299152452] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:771; }","duration":"1.869007302s","start":"2026-05-31T17:22:52.783691Z","end":"2026-05-31T17:22:54.652698Z","steps":["trace[1299152452] 'agreement among raft nodes before linearized reading' (duration: 1.868752285s)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:22:54.652989Z","caller":"traceutil/trace.go:171","msg":"trace[625772494] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"834.493528ms","start":"2026-05-31T17:22:53.818407Z","end":"2026-05-31T17:22:54.6529Z","steps":["trace[625772494] 'process raft request' (duration: 833.725329ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:54.653169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:52.78364Z","time spent":"1.869438593s","remote":"127.0.0.1:60730","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-05-31T17:22:54.653176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.378346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-31T17:22:54.653266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:53.818325Z","time spent":"834.898687ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-31T17:22:54.653275Z","caller":"traceutil/trace.go:171","msg":"trace[309230597] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:771; }","duration":"267.57115ms","start":"2026-05-31T17:22:54.385692Z","end":"2026-05-31T17:22:54.653263Z","steps":["trace[309230597] 'agreement among raft nodes before linearized reading' (duration: 267.383886ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:22:54.654525Z","caller":"traceutil/trace.go:171","msg":"trace[1584755735] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"1.026041179s","start":"2026-05-31T17:22:53.626312Z","end":"2026-05-31T17:22:54.652353Z","steps":["trace[1584755735] 'process raft request' (duration: 1.025273331s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:54.654639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:22:53.626294Z","time spent":"1.028281353s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-31T17:22:57.770342Z","caller":"traceutil/trace.go:171","msg":"trace[1735498839] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"129.193904ms","start":"2026-05-31T17:22:57.641126Z","end":"2026-05-31T17:22:57.77032Z","steps":["trace[1735498839] 'process raft request' (duration: 129.04918ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:22:59.277845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.623084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050260"} {"level":"info","ts":"2026-05-31T17:22:59.277939Z","caller":"traceutil/trace.go:171","msg":"trace[2132777626] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:820; }","duration":"232.783948ms","start":"2026-05-31T17:22:59.045135Z","end":"2026-05-31T17:22:59.277919Z","steps":["trace[2132777626] 'range keys from in-memory index tree' (duration: 231.433296ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:23:04.397991Z","caller":"traceutil/trace.go:171","msg":"trace[1394643037] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"116.638801ms","start":"2026-05-31T17:23:04.28133Z","end":"2026-05-31T17:23:04.397969Z","steps":["trace[1394643037] 'process raft request' (duration: 116.466427ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:23:24.833289Z","caller":"traceutil/trace.go:171","msg":"trace[1638035792] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"813.949777ms","start":"2026-05-31T17:23:24.019311Z","end":"2026-05-31T17:23:24.833261Z","steps":["trace[1638035792] 'process raft request' (duration: 813.778642ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:23:24.833481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:24.01928Z","time spent":"814.108001ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-31T17:23:24.900216Z","caller":"traceutil/trace.go:171","msg":"trace[1490646996] linearizableReadLoop","detail":"{readStateIndex:998; appliedIndex:996; }","duration":"299.420088ms","start":"2026-05-31T17:23:24.600726Z","end":"2026-05-31T17:23:24.900146Z","steps":["trace[1490646996] 'read index received' (duration: 232.461416ms)","trace[1490646996] 'applied index is now lower than readState.Index' (duration: 66.957652ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:23:24.900412Z","caller":"traceutil/trace.go:171","msg":"trace[89821824] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"307.169262ms","start":"2026-05-31T17:23:24.5932Z","end":"2026-05-31T17:23:24.900369Z","steps":["trace[89821824] 'process raft request' (duration: 263.438073ms)","trace[89821824] 'compare' (duration: 43.385731ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T17:23:24.900552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:24.593175Z","time spent":"307.276194ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-31T17:23:24.900592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.841968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-31T17:23:24.900683Z","caller":"traceutil/trace.go:171","msg":"trace[1221353978] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:962; }","duration":"299.96457ms","start":"2026-05-31T17:23:24.600696Z","end":"2026-05-31T17:23:24.900661Z","steps":["trace[1221353978] 'agreement among raft nodes before linearized reading' (duration: 299.834357ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:23:24.900736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:24.600685Z","time spent":"300.040613ms","remote":"127.0.0.1:60480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-31T17:23:28.190454Z","caller":"traceutil/trace.go:171","msg":"trace[272594260] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"131.262849ms","start":"2026-05-31T17:23:28.05916Z","end":"2026-05-31T17:23:28.190423Z","steps":["trace[272594260] 'process raft request' (duration: 103.784316ms)","trace[272594260] 'compare' (duration: 27.364241ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:23:31.333002Z","caller":"traceutil/trace.go:171","msg":"trace[174294394] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"474.390736ms","start":"2026-05-31T17:23:30.858581Z","end":"2026-05-31T17:23:31.332972Z","steps":["trace[174294394] 'process raft request' (duration: 474.207342ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:23:31.333216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:30.858565Z","time spent":"474.556039ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-31T17:23:32.398436Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.065708041s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-31T17:23:32.431276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"778.652428ms","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-05-31T17:23:32.43143Z","caller":"traceutil/trace.go:171","msg":"trace[665729663] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:986; }","duration":"778.816012ms","start":"2026-05-31T17:23:31.652589Z","end":"2026-05-31T17:23:32.431405Z","steps":["trace[665729663] 'range keys from in-memory index tree' (duration: 778.637017ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:23:32.43145Z","caller":"traceutil/trace.go:171","msg":"trace[379975439] linearizableReadLoop","detail":"{readStateIndex:1025; appliedIndex:1023; }","duration":"1.451388267s","start":"2026-05-31T17:23:30.980045Z","end":"2026-05-31T17:23:32.431434Z","steps":["trace[379975439] 'read index received' (duration: 352.731913ms)","trace[379975439] 'applied index is now lower than readState.Index' (duration: 1.098655394s)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:23:32.431645Z","caller":"traceutil/trace.go:171","msg":"trace[1755698685] transaction","detail":"{read_only:false; response_revision:987; number_of_response:1; }","duration":"1.51289755s","start":"2026-05-31T17:23:30.918736Z","end":"2026-05-31T17:23:32.431633Z","steps":["trace[1755698685] 'process raft request' (duration: 1.479912916s)","trace[1755698685] 'compare' (duration: 32.689157ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T17:23:32.431741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:30.918708Z","time spent":"1.512966141s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-31T17:23:32.431788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.451743886s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-31T17:23:32.431836Z","caller":"traceutil/trace.go:171","msg":"trace[198705463] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:987; }","duration":"1.451830768s","start":"2026-05-31T17:23:30.979991Z","end":"2026-05-31T17:23:32.431822Z","steps":["trace[198705463] 'agreement among raft nodes before linearized reading' (duration: 1.451670225s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:23:32.431878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:30.979971Z","time spent":"1.45189549s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-31T17:23:32.830321Z","caller":"traceutil/trace.go:171","msg":"trace[2049365503] linearizableReadLoop","detail":"{readStateIndex:1026; appliedIndex:1025; }","duration":"398.8132ms","start":"2026-05-31T17:23:32.431486Z","end":"2026-05-31T17:23:32.830299Z","steps":["trace[2049365503] 'read index received' (duration: 395.90492ms)","trace[2049365503] 'applied index is now lower than readState.Index' (duration: 2.90754ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T17:23:32.830411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.227749202s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-31T17:23:32.830456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.737040857s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-05-31T17:23:32.83047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.81585116s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-31T17:23:32.830498Z","caller":"traceutil/trace.go:171","msg":"trace[1933864499] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:988; }","duration":"1.815906172s","start":"2026-05-31T17:23:31.014583Z","end":"2026-05-31T17:23:32.830489Z","steps":["trace[1933864499] 'agreement among raft nodes before linearized reading' (duration: 1.815793129s)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:23:32.830503Z","caller":"traceutil/trace.go:171","msg":"trace[316342482] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:988; }","duration":"1.737117549s","start":"2026-05-31T17:23:31.093371Z","end":"2026-05-31T17:23:32.830489Z","steps":["trace[316342482] 'agreement among raft nodes before linearized reading' (duration: 1.736954655s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:23:32.830526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:31.014575Z","time spent":"1.815945713s","remote":"127.0.0.1:60730","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":"warn","ts":"2026-05-31T17:23:32.830536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:31.093356Z","time spent":"1.73717183s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-31T17:23:32.830538Z","caller":"traceutil/trace.go:171","msg":"trace[1779964829] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"926.314367ms","start":"2026-05-31T17:23:31.904212Z","end":"2026-05-31T17:23:32.830526Z","steps":["trace[1779964829] 'process raft request' (duration: 923.167222ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:23:32.830489Z","caller":"traceutil/trace.go:171","msg":"trace[475697569] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:988; }","duration":"1.227879556s","start":"2026-05-31T17:23:31.602591Z","end":"2026-05-31T17:23:32.830471Z","steps":["trace[475697569] 'agreement among raft nodes before linearized reading' (duration: 1.227733042s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:23:32.830514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.738897431s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-31T17:23:32.830582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"966.960684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-31T17:23:32.830604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:31.602566Z","time spent":"1.228018758s","remote":"127.0.0.1:60480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-31T17:23:32.830617Z","caller":"traceutil/trace.go:171","msg":"trace[1310064958] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:988; }","duration":"1.739054855s","start":"2026-05-31T17:23:31.091546Z","end":"2026-05-31T17:23:32.830601Z","steps":["trace[1310064958] 'agreement among raft nodes before linearized reading' (duration: 1.73883758s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:23:32.830627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:31.904169Z","time spent":"926.399989ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-31T17:23:32.830645Z","caller":"traceutil/trace.go:171","msg":"trace[1056948146] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:988; }","duration":"967.033975ms","start":"2026-05-31T17:23:31.863595Z","end":"2026-05-31T17:23:32.830629Z","steps":["trace[1056948146] 'agreement among raft nodes before linearized reading' (duration: 966.930613ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:23:32.830676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:31.091526Z","time spent":"1.739140537s","remote":"127.0.0.1:60730","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-05-31T17:23:32.83069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:31.863538Z","time spent":"967.134327ms","remote":"127.0.0.1:60736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":3,"response size":29,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"info","ts":"2026-05-31T17:23:32.835925Z","caller":"traceutil/trace.go:171","msg":"trace[1923683045] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"399.963817ms","start":"2026-05-31T17:23:32.435949Z","end":"2026-05-31T17:23:32.835913Z","steps":["trace[1923683045] 'process raft request' (duration: 399.815093ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:23:32.836019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:32.435933Z","time spent":"400.028038ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-31T17:23:53.102512Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220203905760793,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-31T17:23:53.603096Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220203905760793,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-31T17:23:53.97321Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.462148043s","expected-duration":"1s"} {"level":"info","ts":"2026-05-31T17:23:53.9739Z","caller":"traceutil/trace.go:171","msg":"trace[193903429] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"1.462927671s","start":"2026-05-31T17:23:52.510943Z","end":"2026-05-31T17:23:53.97387Z","steps":["trace[193903429] 'process raft request' (duration: 1.462569152s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:23:53.974191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:52.51092Z","time spent":"1.463140266s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-31T17:23:54.580161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.05799ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-31T17:23:54.5803Z","caller":"traceutil/trace.go:171","msg":"trace[1356354263] linearizableReadLoop","detail":"{readStateIndex:1096; appliedIndex:1094; }","duration":"1.978646069s","start":"2026-05-31T17:23:52.601636Z","end":"2026-05-31T17:23:54.580282Z","steps":["trace[1356354263] 'read index received' (duration: 1.371786925s)","trace[1356354263] 'applied index is now lower than readState.Index' (duration: 606.857654ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:23:54.58039Z","caller":"traceutil/trace.go:171","msg":"trace[773183401] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"1.615376755s","start":"2026-05-31T17:23:52.965002Z","end":"2026-05-31T17:23:54.580378Z","steps":["trace[773183401] 'process raft request' (duration: 1.203984417s)","trace[773183401] 'compare' (duration: 410.885356ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T17:23:54.580467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:52.964988Z","time spent":"1.615448136s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-31T17:23:54.580686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.979045939s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-31T17:23:54.580726Z","caller":"traceutil/trace.go:171","msg":"trace[1811297604] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1054; }","duration":"1.979126281s","start":"2026-05-31T17:23:52.601591Z","end":"2026-05-31T17:23:54.580717Z","steps":["trace[1811297604] 'agreement among raft nodes before linearized reading' (duration: 1.979058529s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:23:54.580754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:52.601572Z","time spent":"1.979176402s","remote":"127.0.0.1:60480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-31T17:23:54.580904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.77626688s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-31T17:23:54.580964Z","caller":"traceutil/trace.go:171","msg":"trace[739274558] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1054; }","duration":"1.776364292s","start":"2026-05-31T17:23:52.804586Z","end":"2026-05-31T17:23:54.58095Z","steps":["trace[739274558] 'agreement among raft nodes before linearized reading' (duration: 1.7762669s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:23:54.581003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:52.804569Z","time spent":"1.776424563s","remote":"127.0.0.1:39568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-31T17:23:54.581208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.239167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-31T17:23:54.581247Z","caller":"traceutil/trace.go:171","msg":"trace[917168819] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1054; }","duration":"563.312969ms","start":"2026-05-31T17:23:54.017925Z","end":"2026-05-31T17:23:54.581238Z","steps":["trace[917168819] 'agreement among raft nodes before linearized reading' (duration: 563.252668ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:23:54.581276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:54.017904Z","time spent":"563.364741ms","remote":"127.0.0.1:60772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":27,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-05-31T17:23:54.581443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.078155926s","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-05-31T17:23:54.581472Z","caller":"traceutil/trace.go:171","msg":"trace[704355472] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1054; }","duration":"1.078228408s","start":"2026-05-31T17:23:53.503235Z","end":"2026-05-31T17:23:54.581464Z","steps":["trace[704355472] 'agreement among raft nodes before linearized reading' (duration: 1.078184997s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:23:54.5815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:53.503215Z","time spent":"1.078277409s","remote":"127.0.0.1:39712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-31T17:23:54.581699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.156632181s","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-05-31T17:23:54.581736Z","caller":"traceutil/trace.go:171","msg":"trace[724411553] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1054; }","duration":"1.156695803s","start":"2026-05-31T17:23:53.425031Z","end":"2026-05-31T17:23:54.581727Z","steps":["trace[724411553] 'agreement among raft nodes before linearized reading' (duration: 1.15657407s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:23:54.581763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:53.425017Z","time spent":"1.156738113s","remote":"127.0.0.1:60730","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-05-31T17:23:54.581946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.628018765s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-05-31T17:23:54.581956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.624304186s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-31T17:23:54.582052Z","caller":"traceutil/trace.go:171","msg":"trace[64264787] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1054; }","duration":"1.6244348s","start":"2026-05-31T17:23:52.9576Z","end":"2026-05-31T17:23:54.582035Z","steps":["trace[64264787] 'agreement among raft nodes before linearized reading' (duration: 1.624220365s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:23:54.582105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:52.957588Z","time spent":"1.624508851s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-31T17:23:54.582225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.326859607s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-31T17:23:54.581981Z","caller":"traceutil/trace.go:171","msg":"trace[1487878520] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1054; }","duration":"1.628100397s","start":"2026-05-31T17:23:52.953873Z","end":"2026-05-31T17:23:54.581973Z","steps":["trace[1487878520] 'agreement among raft nodes before linearized reading' (duration: 1.627995144s)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:23:54.582272Z","caller":"traceutil/trace.go:171","msg":"trace[866685725] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1054; }","duration":"1.326932568s","start":"2026-05-31T17:23:53.25533Z","end":"2026-05-31T17:23:54.582262Z","steps":["trace[866685725] 'agreement among raft nodes before linearized reading' (duration: 1.326868717s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:23:54.582303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:53.255316Z","time spent":"1.32697925s","remote":"127.0.0.1:39772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-05-31T17:23:54.582306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:52.953853Z","time spent":"1.628440155s","remote":"127.0.0.1:60730","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":"warn","ts":"2026-05-31T17:23:54.582286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.623063117s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-31T17:23:54.582393Z","caller":"traceutil/trace.go:171","msg":"trace[1046504849] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1054; }","duration":"1.623214041s","start":"2026-05-31T17:23:52.959155Z","end":"2026-05-31T17:23:54.582369Z","steps":["trace[1046504849] 'agreement among raft nodes before linearized reading' (duration: 1.622891943s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:23:54.582435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.623688842s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-31T17:23:54.582641Z","caller":"traceutil/trace.go:171","msg":"trace[431073187] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1054; }","duration":"1.623911407s","start":"2026-05-31T17:23:52.958718Z","end":"2026-05-31T17:23:54.582629Z","steps":["trace[431073187] 'agreement among raft nodes before linearized reading' (duration: 1.623483787s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:23:54.582681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:52.958705Z","time spent":"1.623963219s","remote":"127.0.0.1:60730","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-05-31T17:23:54.582448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:52.959144Z","time spent":"1.623294423s","remote":"127.0.0.1:60730","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-05-31T17:23:54.745882Z","caller":"traceutil/trace.go:171","msg":"trace[714521828] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"159.527632ms","start":"2026-05-31T17:23:54.58633Z","end":"2026-05-31T17:23:54.745858Z","steps":["trace[714521828] 'process raft request' (duration: 93.79263ms)","trace[714521828] 'compare' (duration: 65.559418ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:23:54.746236Z","caller":"traceutil/trace.go:171","msg":"trace[785772339] transaction","detail":"{read_only:false; response_revision:1056; number_of_response:1; }","duration":"159.896461ms","start":"2026-05-31T17:23:54.58633Z","end":"2026-05-31T17:23:54.746227Z","steps":["trace[785772339] 'process raft request' (duration: 159.489301ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:23:54.805341Z","caller":"traceutil/trace.go:171","msg":"trace[669171829] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"217.856138ms","start":"2026-05-31T17:23:54.587458Z","end":"2026-05-31T17:23:54.805315Z","steps":["trace[669171829] 'process raft request' (duration: 217.623473ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:23:54.805536Z","caller":"traceutil/trace.go:171","msg":"trace[1560416154] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"217.94257ms","start":"2026-05-31T17:23:54.587585Z","end":"2026-05-31T17:23:54.805527Z","steps":["trace[1560416154] 'process raft request' (duration: 217.691894ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:23:54.805633Z","caller":"traceutil/trace.go:171","msg":"trace[88054571] linearizableReadLoop","detail":"{readStateIndex:1101; appliedIndex:1096; }","duration":"215.090572ms","start":"2026-05-31T17:23:54.590532Z","end":"2026-05-31T17:23:54.805623Z","steps":["trace[88054571] 'read index received' (duration: 89.60916ms)","trace[88054571] 'applied index is now lower than readState.Index' (duration: 125.480442ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T17:23:54.805702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.146474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-31T17:23:54.805727Z","caller":"traceutil/trace.go:171","msg":"trace[1912540486] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1059; }","duration":"215.207855ms","start":"2026-05-31T17:23:54.590513Z","end":"2026-05-31T17:23:54.805721Z","steps":["trace[1912540486] 'agreement among raft nodes before linearized reading' (duration: 215.137523ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:23:54.80585Z","caller":"traceutil/trace.go:171","msg":"trace[354673893] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"218.183356ms","start":"2026-05-31T17:23:54.587657Z","end":"2026-05-31T17:23:54.805841Z","steps":["trace[354673893] 'process raft request' (duration: 217.838017ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:23:55.981732Z","caller":"traceutil/trace.go:171","msg":"trace[2144025710] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"103.50289ms","start":"2026-05-31T17:23:55.878202Z","end":"2026-05-31T17:23:55.981705Z","steps":["trace[2144025710] 'process raft request' (duration: 103.338046ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:23:57.037404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"780.296267ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-31T17:23:57.037568Z","caller":"traceutil/trace.go:171","msg":"trace[636149914] linearizableReadLoop","detail":"{readStateIndex:1104; appliedIndex:1103; }","duration":"536.252507ms","start":"2026-05-31T17:23:56.501289Z","end":"2026-05-31T17:23:57.037541Z","steps":["trace[636149914] 'read index received' (duration: 36.991µs)","trace[636149914] 'applied index is now lower than readState.Index' (duration: 536.213476ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:23:57.03784Z","caller":"traceutil/trace.go:171","msg":"trace[1543762024] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"1.0589662s","start":"2026-05-31T17:23:55.978815Z","end":"2026-05-31T17:23:57.037781Z","steps":["trace[1543762024] 'process raft request' (duration: 278.190703ms)","trace[1543762024] 'compare' (duration: 780.161933ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T17:23:57.037958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.656755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-31T17:23:57.037971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:55.978788Z","time spent":"1.059107403s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-31T17:23:57.037993Z","caller":"traceutil/trace.go:171","msg":"trace[933832468] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1061; }","duration":"435.731917ms","start":"2026-05-31T17:23:56.602252Z","end":"2026-05-31T17:23:57.037984Z","steps":["trace[933832468] 'agreement among raft nodes before linearized reading' (duration: 435.674116ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:23:57.038014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:56.602232Z","time spent":"435.778499ms","remote":"127.0.0.1:60480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-31T17:23:57.038103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.365604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-31T17:23:57.038175Z","caller":"traceutil/trace.go:171","msg":"trace[331953114] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1061; }","duration":"288.491377ms","start":"2026-05-31T17:23:56.74967Z","end":"2026-05-31T17:23:57.038161Z","steps":["trace[331953114] 'agreement among raft nodes before linearized reading' (duration: 288.303793ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:23:57.038211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.232206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-31T17:23:57.03811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.352108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-31T17:23:57.038271Z","caller":"traceutil/trace.go:171","msg":"trace[762531484] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1061; }","duration":"228.553443ms","start":"2026-05-31T17:23:56.809711Z","end":"2026-05-31T17:23:57.038264Z","steps":["trace[762531484] 'agreement among raft nodes before linearized reading' (duration: 228.234705ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:23:57.038266Z","caller":"traceutil/trace.go:171","msg":"trace[726581635] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1061; }","duration":"228.292667ms","start":"2026-05-31T17:23:56.809956Z","end":"2026-05-31T17:23:57.038249Z","steps":["trace[726581635] 'agreement among raft nodes before linearized reading' (duration: 228.200174ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:23:57.038218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.748764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-31T17:23:57.038225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.887021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-31T17:23:57.038333Z","caller":"traceutil/trace.go:171","msg":"trace[650857460] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1061; }","duration":"288.894166ms","start":"2026-05-31T17:23:56.749433Z","end":"2026-05-31T17:23:57.038327Z","steps":["trace[650857460] 'agreement among raft nodes before linearized reading' (duration: 288.695602ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:23:57.038402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.648195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-31T17:23:57.038501Z","caller":"traceutil/trace.go:171","msg":"trace[316339408] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1061; }","duration":"228.789928ms","start":"2026-05-31T17:23:56.809694Z","end":"2026-05-31T17:23:57.038483Z","steps":["trace[316339408] 'agreement among raft nodes before linearized reading' (duration: 228.416549ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:23:57.038366Z","caller":"traceutil/trace.go:171","msg":"trace[339812950] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1061; }","duration":"537.107247ms","start":"2026-05-31T17:23:56.501235Z","end":"2026-05-31T17:23:57.038342Z","steps":["trace[339812950] 'agreement among raft nodes before linearized reading' (duration: 536.881491ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:23:57.038872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:56.50121Z","time spent":"537.64352ms","remote":"127.0.0.1:39644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-05-31T17:23:57.167482Z","caller":"traceutil/trace.go:171","msg":"trace[1764166039] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"124.881558ms","start":"2026-05-31T17:23:57.042573Z","end":"2026-05-31T17:23:57.167454Z","steps":["trace[1764166039] 'process raft request' (duration: 124.628902ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:23:57.16746Z","caller":"traceutil/trace.go:171","msg":"trace[1063411165] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"124.668873ms","start":"2026-05-31T17:23:57.042765Z","end":"2026-05-31T17:23:57.167434Z","steps":["trace[1063411165] 'process raft request' (duration: 124.585861ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:23:57.167849Z","caller":"traceutil/trace.go:171","msg":"trace[2032331791] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"125.030972ms","start":"2026-05-31T17:23:57.042795Z","end":"2026-05-31T17:23:57.167826Z","steps":["trace[2032331791] 'process raft request' (duration: 124.599322ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:23:57.16799Z","caller":"traceutil/trace.go:171","msg":"trace[1379997943] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"124.98202ms","start":"2026-05-31T17:23:57.04299Z","end":"2026-05-31T17:23:57.167972Z","steps":["trace[1379997943] 'process raft request' (duration: 124.749785ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:23:59.285629Z","caller":"traceutil/trace.go:171","msg":"trace[747481507] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"105.063197ms","start":"2026-05-31T17:23:59.180536Z","end":"2026-05-31T17:23:59.285599Z","steps":["trace[747481507] 'process raft request' (duration: 50.844498ms)","trace[747481507] 'compare' (duration: 54.080106ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:23:59.293207Z","caller":"traceutil/trace.go:171","msg":"trace[389919884] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"112.642257ms","start":"2026-05-31T17:23:59.180546Z","end":"2026-05-31T17:23:59.293188Z","steps":["trace[389919884] 'process raft request' (duration: 112.375501ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:23:59.293221Z","caller":"traceutil/trace.go:171","msg":"trace[1828611874] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"112.054934ms","start":"2026-05-31T17:23:59.181144Z","end":"2026-05-31T17:23:59.293199Z","steps":["trace[1828611874] 'process raft request' (duration: 112.001212ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:23:59.293417Z","caller":"traceutil/trace.go:171","msg":"trace[651286587] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"112.31064ms","start":"2026-05-31T17:23:59.181021Z","end":"2026-05-31T17:23:59.293332Z","steps":["trace[651286587] 'process raft request' (duration: 112.077864ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:00.081923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.279172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-31T17:24:00.082012Z","caller":"traceutil/trace.go:171","msg":"trace[408934744] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1072; }","duration":"479.412695ms","start":"2026-05-31T17:23:59.602574Z","end":"2026-05-31T17:24:00.081986Z","steps":["trace[408934744] 'range keys from in-memory index tree' (duration: 479.140889ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:00.082056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:23:59.60254Z","time spent":"479.506097ms","remote":"127.0.0.1:60480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-31T17:24:00.549569Z","caller":"traceutil/trace.go:171","msg":"trace[2113989354] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"363.89805ms","start":"2026-05-31T17:24:00.185633Z","end":"2026-05-31T17:24:00.549531Z","steps":["trace[2113989354] 'process raft request' (duration: 264.877466ms)","trace[2113989354] 'compare' (duration: 98.86207ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T17:24:00.549752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:00.185607Z","time spent":"364.050823ms","remote":"127.0.0.1:60498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-31T17:24:13.658536Z","caller":"traceutil/trace.go:171","msg":"trace[603164209] transaction","detail":"{read_only:false; response_revision:1119; number_of_response:1; }","duration":"107.484305ms","start":"2026-05-31T17:24:13.55102Z","end":"2026-05-31T17:24:13.658504Z","steps":["trace[603164209] 'process raft request' (duration: 107.29762ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:15.477187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.736212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-31T17:24:15.47728Z","caller":"traceutil/trace.go:171","msg":"trace[2118797473] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1172; }","duration":"147.890025ms","start":"2026-05-31T17:24:15.329369Z","end":"2026-05-31T17:24:15.477259Z","steps":["trace[2118797473] 'count revisions from in-memory index tree' (duration: 147.605808ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:24:16.510205Z","caller":"traceutil/trace.go:171","msg":"trace[1369907337] linearizableReadLoop","detail":"{readStateIndex:1227; appliedIndex:1226; }","duration":"166.086117ms","start":"2026-05-31T17:24:16.344Z","end":"2026-05-31T17:24:16.510086Z","steps":["trace[1369907337] 'read index received' (duration: 165.858112ms)","trace[1369907337] 'applied index is now lower than readState.Index' (duration: 226.575µs)"],"step_count":2} {"level":"warn","ts":"2026-05-31T17:24:16.510368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.338763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-31T17:24:16.510412Z","caller":"traceutil/trace.go:171","msg":"trace[230819447] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1178; }","duration":"166.404705ms","start":"2026-05-31T17:24:16.343994Z","end":"2026-05-31T17:24:16.510399Z","steps":["trace[230819447] 'agreement among raft nodes before linearized reading' (duration: 166.294962ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:24:16.510556Z","caller":"traceutil/trace.go:171","msg":"trace[52064156] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"333.519007ms","start":"2026-05-31T17:24:16.17699Z","end":"2026-05-31T17:24:16.510509Z","steps":["trace[52064156] 'process raft request' (duration: 332.960904ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:16.510761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:16.176967Z","time spent":"333.700452ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-31T17:24:17.948561Z","caller":"traceutil/trace.go:171","msg":"trace[1267624092] linearizableReadLoop","detail":"{readStateIndex:1228; appliedIndex:1227; }","duration":"454.82057ms","start":"2026-05-31T17:24:17.493713Z","end":"2026-05-31T17:24:17.948533Z","steps":["trace[1267624092] 'read index received' (duration: 454.593885ms)","trace[1267624092] 'applied index is now lower than readState.Index' (duration: 225.535µs)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:24:17.948709Z","caller":"traceutil/trace.go:171","msg":"trace[122236562] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"722.236606ms","start":"2026-05-31T17:24:17.226444Z","end":"2026-05-31T17:24:17.948681Z","steps":["trace[122236562] 'process raft request' (duration: 721.887177ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:17.948845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:17.226416Z","time spent":"722.353979ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-31T17:24:17.948904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.157309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-31T17:24:17.948964Z","caller":"traceutil/trace.go:171","msg":"trace[1025967224] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1179; }","duration":"455.264831ms","start":"2026-05-31T17:24:17.493683Z","end":"2026-05-31T17:24:17.948948Z","steps":["trace[1025967224] 'agreement among raft nodes before linearized reading' (duration: 455.035735ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:17.949021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:17.493669Z","time spent":"455.338403ms","remote":"127.0.0.1:60730","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":"warn","ts":"2026-05-31T17:24:17.949064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.925796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-31T17:24:17.949092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.815021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-31T17:24:17.949144Z","caller":"traceutil/trace.go:171","msg":"trace[1995678427] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1179; }","duration":"449.879333ms","start":"2026-05-31T17:24:17.49925Z","end":"2026-05-31T17:24:17.949129Z","steps":["trace[1995678427] 'agreement among raft nodes before linearized reading' (duration: 449.73981ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:17.949173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.077481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-31T17:24:17.949187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:17.499243Z","time spent":"449.936044ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-31T17:24:17.949199Z","caller":"traceutil/trace.go:171","msg":"trace[1517211876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1179; }","duration":"451.115603ms","start":"2026-05-31T17:24:17.498077Z","end":"2026-05-31T17:24:17.949193Z","steps":["trace[1517211876] 'agreement among raft nodes before linearized reading' (duration: 451.045171ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:17.949226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:17.49807Z","time spent":"451.150403ms","remote":"127.0.0.1:60730","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":"info","ts":"2026-05-31T17:24:17.949103Z","caller":"traceutil/trace.go:171","msg":"trace[910167847] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1179; }","duration":"452.989427ms","start":"2026-05-31T17:24:17.496101Z","end":"2026-05-31T17:24:17.949091Z","steps":["trace[910167847] 'agreement among raft nodes before linearized reading' (duration: 452.863024ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:17.949356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.774781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-31T17:24:17.949352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:17.496085Z","time spent":"453.249853ms","remote":"127.0.0.1:60730","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-05-31T17:24:17.949388Z","caller":"traceutil/trace.go:171","msg":"trace[825399632] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1179; }","duration":"452.814972ms","start":"2026-05-31T17:24:17.496565Z","end":"2026-05-31T17:24:17.94938Z","steps":["trace[825399632] 'agreement among raft nodes before linearized reading' (duration: 452.73865ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:17.949414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:17.49656Z","time spent":"452.847784ms","remote":"127.0.0.1:60730","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-05-31T17:24:17.949505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.205346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-31T17:24:17.949557Z","caller":"traceutil/trace.go:171","msg":"trace[1559664022] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1179; }","duration":"348.273238ms","start":"2026-05-31T17:24:17.601269Z","end":"2026-05-31T17:24:17.949542Z","steps":["trace[1559664022] 'agreement among raft nodes before linearized reading' (duration: 348.198506ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:17.949601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:17.601254Z","time spent":"348.336439ms","remote":"127.0.0.1:60478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-31T17:24:18.54352Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220203905761057,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-31T17:24:19.04372Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220203905761057,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-31T17:24:19.069492Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.056656215s","expected-duration":"1s"} {"level":"info","ts":"2026-05-31T17:24:19.077636Z","caller":"traceutil/trace.go:171","msg":"trace[407188273] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"1.123246418s","start":"2026-05-31T17:24:17.954365Z","end":"2026-05-31T17:24:19.077611Z","steps":["trace[407188273] 'process raft request' (duration: 1.115298299s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:19.07777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:17.954337Z","time spent":"1.12336481s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-31T17:24:19.100705Z","caller":"traceutil/trace.go:171","msg":"trace[74254268] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"1.145376773s","start":"2026-05-31T17:24:17.955304Z","end":"2026-05-31T17:24:19.100681Z","steps":["trace[74254268] 'process raft request' (duration: 1.145291301s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:19.100853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:17.955294Z","time spent":"1.145472836s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-31T17:24:19.100901Z","caller":"traceutil/trace.go:171","msg":"trace[807628194] linearizableReadLoop","detail":"{readStateIndex:1233; appliedIndex:1228; }","duration":"1.057467244s","start":"2026-05-31T17:24:18.043411Z","end":"2026-05-31T17:24:19.100878Z","steps":["trace[807628194] 'read index received' (duration: 1.026262933s)","trace[807628194] 'applied index is now lower than readState.Index' (duration: 31.203201ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:24:19.101143Z","caller":"traceutil/trace.go:171","msg":"trace[1611436079] transaction","detail":"{read_only:false; response_revision:1184; number_of_response:1; }","duration":"1.145115427s","start":"2026-05-31T17:24:17.956014Z","end":"2026-05-31T17:24:19.101129Z","steps":["trace[1611436079] 'process raft request' (duration: 1.144614885s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:19.101242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:17.956004Z","time spent":"1.145174199s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-31T17:24:19.101301Z","caller":"traceutil/trace.go:171","msg":"trace[149623854] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"1.146264755s","start":"2026-05-31T17:24:17.955025Z","end":"2026-05-31T17:24:19.10129Z","steps":["trace[149623854] 'process raft request' (duration: 1.145405434s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:19.101347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:17.955011Z","time spent":"1.146314896s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-31T17:24:19.101463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.058054828s","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":"info","ts":"2026-05-31T17:24:19.101488Z","caller":"traceutil/trace.go:171","msg":"trace[440861129] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1184; }","duration":"1.058099929s","start":"2026-05-31T17:24:18.04338Z","end":"2026-05-31T17:24:19.10148Z","steps":["trace[440861129] 'agreement among raft nodes before linearized reading' (duration: 1.058057898s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:19.101504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:18.043364Z","time spent":"1.05813586s","remote":"127.0.0.1:39592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-05-31T17:24:19.101587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.961532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-31T17:24:19.101605Z","caller":"traceutil/trace.go:171","msg":"trace[1738565472] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1184; }","duration":"611.018473ms","start":"2026-05-31T17:24:18.490582Z","end":"2026-05-31T17:24:19.101601Z","steps":["trace[1738565472] 'agreement among raft nodes before linearized reading' (duration: 610.989083ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:24:19.101579Z","caller":"traceutil/trace.go:171","msg":"trace[307545750] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"1.146451569s","start":"2026-05-31T17:24:17.955104Z","end":"2026-05-31T17:24:19.101556Z","steps":["trace[307545750] 'process raft request' (duration: 1.145451665s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:19.101657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.289501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-31T17:24:19.101675Z","caller":"traceutil/trace.go:171","msg":"trace[584686015] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1184; }","duration":"500.326942ms","start":"2026-05-31T17:24:18.601344Z","end":"2026-05-31T17:24:19.101671Z","steps":["trace[584686015] 'agreement among raft nodes before linearized reading' (duration: 500.303551ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:19.101687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:18.601333Z","time spent":"500.351542ms","remote":"127.0.0.1:60480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-31T17:24:19.101716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:17.955096Z","time spent":"1.146545791s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-31T17:24:19.10162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:18.490562Z","time spent":"611.054814ms","remote":"127.0.0.1:39552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-05-31T17:24:25.33989Z","caller":"traceutil/trace.go:171","msg":"trace[1000684344] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"176.156105ms","start":"2026-05-31T17:24:25.16371Z","end":"2026-05-31T17:24:25.339866Z","steps":["trace[1000684344] 'process raft request' (duration: 176.098563ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:24:25.340008Z","caller":"traceutil/trace.go:171","msg":"trace[1374114249] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"191.506797ms","start":"2026-05-31T17:24:25.148449Z","end":"2026-05-31T17:24:25.339956Z","steps":["trace[1374114249] 'process raft request' (duration: 191.286362ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:24:25.340102Z","caller":"traceutil/trace.go:171","msg":"trace[337774593] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"192.53132ms","start":"2026-05-31T17:24:25.147541Z","end":"2026-05-31T17:24:25.340072Z","steps":["trace[337774593] 'process raft request' (duration: 168.3136ms)","trace[337774593] 'compare' (duration: 23.76909ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:24:25.340147Z","caller":"traceutil/trace.go:171","msg":"trace[1348789523] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"191.267651ms","start":"2026-05-31T17:24:25.148865Z","end":"2026-05-31T17:24:25.340132Z","steps":["trace[1348789523] 'process raft request' (duration: 190.911953ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:35.418384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.210040681s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-31T17:24:35.418474Z","caller":"traceutil/trace.go:171","msg":"trace[1373677848] linearizableReadLoop","detail":"{readStateIndex:1303; appliedIndex:1302; }","duration":"818.226772ms","start":"2026-05-31T17:24:34.600233Z","end":"2026-05-31T17:24:35.41846Z","steps":["trace[1373677848] 'read index received' (duration: 32.641µs)","trace[1373677848] 'applied index is now lower than readState.Index' (duration: 818.193391ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:24:35.418529Z","caller":"traceutil/trace.go:171","msg":"trace[1497772675] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"1.347652949s","start":"2026-05-31T17:24:34.070865Z","end":"2026-05-31T17:24:35.418518Z","steps":["trace[1497772675] 'process raft request' (duration: 137.408333ms)","trace[1497772675] 'compare' (duration: 1.209612301s)"],"step_count":2} {"level":"warn","ts":"2026-05-31T17:24:35.418565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:34.070853Z","time spent":"1.3476929s","remote":"127.0.0.1:60852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":797,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-31T17:24:35.419536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"819.282996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-31T17:24:35.419659Z","caller":"traceutil/trace.go:171","msg":"trace[173423734] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1251; }","duration":"819.41456ms","start":"2026-05-31T17:24:34.6002Z","end":"2026-05-31T17:24:35.419615Z","steps":["trace[173423734] 'agreement among raft nodes before linearized reading' (duration: 818.336494ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:35.419707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:34.600187Z","time spent":"819.509302ms","remote":"127.0.0.1:60480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-31T17:24:35.772104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.703607ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-31T17:24:35.772379Z","caller":"traceutil/trace.go:171","msg":"trace[1725614529] linearizableReadLoop","detail":"{readStateIndex:1304; appliedIndex:1303; }","duration":"353.853707ms","start":"2026-05-31T17:24:35.418492Z","end":"2026-05-31T17:24:35.772345Z","steps":["trace[1725614529] 'read index received' (duration: 230.997326ms)","trace[1725614529] 'applied index is now lower than readState.Index' (duration: 122.853041ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:24:35.772446Z","caller":"traceutil/trace.go:171","msg":"trace[275189944] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"157.085956ms","start":"2026-05-31T17:24:35.615336Z","end":"2026-05-31T17:24:35.772421Z","steps":["trace[275189944] 'process raft request' (duration: 156.930553ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:35.772501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.747551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-31T17:24:35.772496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.732876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-31T17:24:35.772537Z","caller":"traceutil/trace.go:171","msg":"trace[910612983] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1252; }","duration":"681.838783ms","start":"2026-05-31T17:24:35.090687Z","end":"2026-05-31T17:24:35.772526Z","steps":["trace[910612983] 'agreement among raft nodes before linearized reading' (duration: 681.758941ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:24:35.772562Z","caller":"traceutil/trace.go:171","msg":"trace[1367700902] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1251; }","duration":"433.850728ms","start":"2026-05-31T17:24:35.338696Z","end":"2026-05-31T17:24:35.772546Z","steps":["trace[1367700902] 'agreement among raft nodes before linearized reading' (duration: 433.653064ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:35.772567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:35.090665Z","time spent":"681.894114ms","remote":"127.0.0.1:48454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-31T17:24:35.772592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:35.338675Z","time spent":"433.91035ms","remote":"127.0.0.1:60730","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":"warn","ts":"2026-05-31T17:24:35.772604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.061027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-31T17:24:35.772634Z","caller":"traceutil/trace.go:171","msg":"trace[1633974478] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1252; }","duration":"350.147479ms","start":"2026-05-31T17:24:35.422478Z","end":"2026-05-31T17:24:35.772625Z","steps":["trace[1633974478] 'agreement among raft nodes before linearized reading' (duration: 350.042567ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:35.772624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.901653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-31T17:24:35.772657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:35.422428Z","time spent":"350.223491ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-31T17:24:35.772681Z","caller":"traceutil/trace.go:171","msg":"trace[1416343382] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1252; }","duration":"346.998495ms","start":"2026-05-31T17:24:35.425667Z","end":"2026-05-31T17:24:35.772665Z","steps":["trace[1416343382] 'agreement among raft nodes before linearized reading' (duration: 346.881032ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:35.772681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.096278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-31T17:24:35.772711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:35.425652Z","time spent":"347.053256ms","remote":"127.0.0.1:60478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-31T17:24:35.772731Z","caller":"traceutil/trace.go:171","msg":"trace[1086249375] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1252; }","duration":"350.18785ms","start":"2026-05-31T17:24:35.422527Z","end":"2026-05-31T17:24:35.772715Z","steps":["trace[1086249375] 'agreement among raft nodes before linearized reading' (duration: 350.058457ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:35.772724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.22418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-31T17:24:35.772772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:35.422504Z","time spent":"350.258691ms","remote":"127.0.0.1:60730","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":"info","ts":"2026-05-31T17:24:35.772784Z","caller":"traceutil/trace.go:171","msg":"trace[439650122] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1252; }","duration":"347.310523ms","start":"2026-05-31T17:24:35.425461Z","end":"2026-05-31T17:24:35.772771Z","steps":["trace[439650122] 'agreement among raft nodes before linearized reading' (duration: 347.073007ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:35.772822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:35.425453Z","time spent":"347.360654ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-31T17:24:35.774131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.137423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-31T17:24:35.774194Z","caller":"traceutil/trace.go:171","msg":"trace[1609649471] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1252; }","duration":"544.240306ms","start":"2026-05-31T17:24:35.229936Z","end":"2026-05-31T17:24:35.774176Z","steps":["trace[1609649471] 'agreement among raft nodes before linearized reading' (duration: 542.426493ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:35.774243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:35.229913Z","time spent":"544.317708ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-31T17:24:36.065652Z","caller":"traceutil/trace.go:171","msg":"trace[1064339458] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"290.211208ms","start":"2026-05-31T17:24:35.775413Z","end":"2026-05-31T17:24:36.065624Z","steps":["trace[1064339458] 'process raft request' (duration: 263.898259ms)","trace[1064339458] 'compare' (duration: 25.827398ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:24:36.079584Z","caller":"traceutil/trace.go:171","msg":"trace[1682085198] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"300.679366ms","start":"2026-05-31T17:24:35.778892Z","end":"2026-05-31T17:24:36.079571Z","steps":["trace[1682085198] 'process raft request' (duration: 300.596204ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:36.079669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:35.778875Z","time spent":"300.745937ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-31T17:24:36.079771Z","caller":"traceutil/trace.go:171","msg":"trace[86420896] linearizableReadLoop","detail":"{readStateIndex:1310; appliedIndex:1305; }","duration":"298.289599ms","start":"2026-05-31T17:24:35.781472Z","end":"2026-05-31T17:24:36.079761Z","steps":["trace[86420896] 'read index received' (duration: 257.823077ms)","trace[86420896] 'applied index is now lower than readState.Index' (duration: 40.465812ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:24:36.07979Z","caller":"traceutil/trace.go:171","msg":"trace[1418968266] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"300.748927ms","start":"2026-05-31T17:24:35.779031Z","end":"2026-05-31T17:24:36.07978Z","steps":["trace[1418968266] 'process raft request' (duration: 300.663645ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:36.079837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:35.779022Z","time spent":"300.791778ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-31T17:24:36.079843Z","caller":"traceutil/trace.go:171","msg":"trace[1861841268] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"300.85464ms","start":"2026-05-31T17:24:35.77898Z","end":"2026-05-31T17:24:36.079835Z","steps":["trace[1861841268] 'process raft request' (duration: 300.572413ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:24:36.079837Z","caller":"traceutil/trace.go:171","msg":"trace[119223432] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"300.730166ms","start":"2026-05-31T17:24:35.779077Z","end":"2026-05-31T17:24:36.079807Z","steps":["trace[119223432] 'process raft request' (duration: 300.658285ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:36.079868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.387951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-31T17:24:36.079893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:35.778973Z","time spent":"300.88728ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-31T17:24:36.079912Z","caller":"traceutil/trace.go:171","msg":"trace[1429152019] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1257; }","duration":"298.446452ms","start":"2026-05-31T17:24:35.781454Z","end":"2026-05-31T17:24:36.0799Z","steps":["trace[1429152019] 'agreement among raft nodes before linearized reading' (duration: 298.36246ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:36.079976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:35.779071Z","time spent":"300.829188ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-31T17:24:37.334511Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220203905761228,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-31T17:24:37.469955Z","caller":"traceutil/trace.go:171","msg":"trace[1941028562] linearizableReadLoop","detail":"{readStateIndex:1312; appliedIndex:1311; }","duration":"636.124288ms","start":"2026-05-31T17:24:36.833805Z","end":"2026-05-31T17:24:37.469929Z","steps":["trace[1941028562] 'read index received' (duration: 635.885023ms)","trace[1941028562] 'applied index is now lower than readState.Index' (duration: 238.505µs)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:24:37.470328Z","caller":"traceutil/trace.go:171","msg":"trace[1859324998] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"749.793962ms","start":"2026-05-31T17:24:36.720521Z","end":"2026-05-31T17:24:37.470315Z","steps":["trace[1859324998] 'process raft request' (duration: 749.24771ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:37.470442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:36.720484Z","time spent":"749.882685ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-31T17:24:37.47066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.848335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-31T17:24:37.470703Z","caller":"traceutil/trace.go:171","msg":"trace[1047826532] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1259; }","duration":"636.931437ms","start":"2026-05-31T17:24:36.83376Z","end":"2026-05-31T17:24:37.470691Z","steps":["trace[1047826532] 'agreement among raft nodes before linearized reading' (duration: 636.863146ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:37.47074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:36.833737Z","time spent":"636.994988ms","remote":"127.0.0.1:48462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-05-31T17:24:37.470954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.791562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-31T17:24:37.470994Z","caller":"traceutil/trace.go:171","msg":"trace[608128524] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1259; }","duration":"545.859674ms","start":"2026-05-31T17:24:36.925126Z","end":"2026-05-31T17:24:37.470985Z","steps":["trace[608128524] 'agreement among raft nodes before linearized reading' (duration: 545.802903ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:37.471026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:36.925112Z","time spent":"545.908495ms","remote":"127.0.0.1:60480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-31T17:24:38.225612Z","caller":"traceutil/trace.go:171","msg":"trace[1780919098] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"119.506972ms","start":"2026-05-31T17:24:38.10608Z","end":"2026-05-31T17:24:38.225587Z","steps":["trace[1780919098] 'process raft request' (duration: 77.085774ms)","trace[1780919098] 'compare' (duration: 42.237104ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:24:38.226354Z","caller":"traceutil/trace.go:171","msg":"trace[837810748] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"120.228219ms","start":"2026-05-31T17:24:38.106111Z","end":"2026-05-31T17:24:38.226339Z","steps":["trace[837810748] 'process raft request' (duration: 119.43552ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:24:38.226596Z","caller":"traceutil/trace.go:171","msg":"trace[1837278681] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"119.887951ms","start":"2026-05-31T17:24:38.106678Z","end":"2026-05-31T17:24:38.226566Z","steps":["trace[1837278681] 'process raft request' (duration: 119.591224ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:39.119179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.042501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-31T17:24:39.119276Z","caller":"traceutil/trace.go:171","msg":"trace[205018998] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1266; }","duration":"519.173065ms","start":"2026-05-31T17:24:38.600077Z","end":"2026-05-31T17:24:39.11925Z","steps":["trace[205018998] 'range keys from in-memory index tree' (duration: 518.910169ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:39.119327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:38.600057Z","time spent":"519.257057ms","remote":"127.0.0.1:60478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-31T17:24:46.524986Z","caller":"traceutil/trace.go:171","msg":"trace[568124955] linearizableReadLoop","detail":"{readStateIndex:1381; appliedIndex:1380; }","duration":"382.223384ms","start":"2026-05-31T17:24:46.142733Z","end":"2026-05-31T17:24:46.524956Z","steps":["trace[568124955] 'read index received' (duration: 381.925427ms)","trace[568124955] 'applied index is now lower than readState.Index' (duration: 296.457µs)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:24:46.525135Z","caller":"traceutil/trace.go:171","msg":"trace[1438409760] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"670.076196ms","start":"2026-05-31T17:24:45.855024Z","end":"2026-05-31T17:24:46.5251Z","steps":["trace[1438409760] 'process raft request' (duration: 669.621225ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:46.525232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.47845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-31T17:24:46.525287Z","caller":"traceutil/trace.go:171","msg":"trace[1944701459] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1326; }","duration":"382.590233ms","start":"2026-05-31T17:24:46.142682Z","end":"2026-05-31T17:24:46.525272Z","steps":["trace[1944701459] 'agreement among raft nodes before linearized reading' (duration: 382.410268ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:46.525349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:45.854998Z","time spent":"670.24257ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-31T17:24:46.525333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:46.142658Z","time spent":"382.663225ms","remote":"127.0.0.1:60730","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-05-31T17:24:47.025132Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220203905761354,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-31T17:24:47.526292Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220203905761354,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-31T17:24:48.027261Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220203905761354,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-31T17:24:48.107946Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.310567127s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-31T17:24:48.474752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.445363ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-31T17:24:48.474845Z","caller":"traceutil/trace.go:171","msg":"trace[1937263491] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"2.218148022s","start":"2026-05-31T17:24:46.256682Z","end":"2026-05-31T17:24:48.47483Z","steps":["trace[1937263491] 'process raft request' (duration: 1.851568427s)","trace[1937263491] 'compare' (duration: 366.33098ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T17:24:48.474888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:46.256663Z","time spent":"2.218203644s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-31T17:24:48.512417Z","caller":"traceutil/trace.go:171","msg":"trace[2110357985] linearizableReadLoop","detail":"{readStateIndex:1384; appliedIndex:1381; }","duration":"1.987332921s","start":"2026-05-31T17:24:46.525058Z","end":"2026-05-31T17:24:48.512391Z","steps":["trace[2110357985] 'read index received' (duration: 1.583158821s)","trace[2110357985] 'applied index is now lower than readState.Index' (duration: 404.17292ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T17:24:48.512593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.020261606s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-05-31T17:24:48.512671Z","caller":"traceutil/trace.go:171","msg":"trace[214392282] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1329; }","duration":"2.020393899s","start":"2026-05-31T17:24:46.492259Z","end":"2026-05-31T17:24:48.512653Z","steps":["trace[214392282] 'agreement among raft nodes before linearized reading' (duration: 2.020144054s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:48.512705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.262031366s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-05-31T17:24:48.512748Z","caller":"traceutil/trace.go:171","msg":"trace[1764557573] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1329; }","duration":"2.262108567s","start":"2026-05-31T17:24:46.250626Z","end":"2026-05-31T17:24:48.512734Z","steps":["trace[1764557573] 'agreement among raft nodes before linearized reading' (duration: 2.262023955s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:48.512783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:46.250606Z","time spent":"2.262169779s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":552,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-05-31T17:24:48.512786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.24695696s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-31T17:24:48.512803Z","caller":"traceutil/trace.go:171","msg":"trace[409129224] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"1.983338578s","start":"2026-05-31T17:24:46.52943Z","end":"2026-05-31T17:24:48.512769Z","steps":["trace[409129224] 'process raft request' (duration: 1.982443537s)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:24:48.512831Z","caller":"traceutil/trace.go:171","msg":"trace[1934959592] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1329; }","duration":"2.247055253s","start":"2026-05-31T17:24:46.265764Z","end":"2026-05-31T17:24:48.51282Z","steps":["trace[1934959592] 'agreement among raft nodes before linearized reading' (duration: 2.246804507s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:48.512709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:46.492169Z","time spent":"2.020534173s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-05-31T17:24:48.512847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.248560829s","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":"warn","ts":"2026-05-31T17:24:48.51286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.975662967s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-31T17:24:48.512883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:46.265757Z","time spent":"2.247114635s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-31T17:24:48.512894Z","caller":"traceutil/trace.go:171","msg":"trace[776786145] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1329; }","duration":"2.24863274s","start":"2026-05-31T17:24:46.264249Z","end":"2026-05-31T17:24:48.512882Z","steps":["trace[776786145] 'agreement among raft nodes before linearized reading' (duration: 2.248500877s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:48.512604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.247326449s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-31T17:24:48.512915Z","caller":"traceutil/trace.go:171","msg":"trace[2018215866] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1329; }","duration":"1.975753909s","start":"2026-05-31T17:24:46.537147Z","end":"2026-05-31T17:24:48.512901Z","steps":["trace[2018215866] 'agreement among raft nodes before linearized reading' (duration: 1.975661027s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:48.512929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:46.264236Z","time spent":"2.248685092s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-31T17:24:48.512931Z","caller":"traceutil/trace.go:171","msg":"trace[753084614] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1329; }","duration":"2.247681308s","start":"2026-05-31T17:24:46.265242Z","end":"2026-05-31T17:24:48.512923Z","steps":["trace[753084614] 'agreement among raft nodes before linearized reading' (duration: 2.247187066s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:48.512954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:46.53713Z","time spent":"1.975814051s","remote":"127.0.0.1:60722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":29,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"warn","ts":"2026-05-31T17:24:48.512958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:46.265232Z","time spent":"2.247719648s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-31T17:24:48.512959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:46.529402Z","time spent":"1.983472571s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-31T17:24:48.512993Z","caller":"traceutil/trace.go:171","msg":"trace[189267414] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"1.011771157s","start":"2026-05-31T17:24:47.50121Z","end":"2026-05-31T17:24:48.512981Z","steps":["trace[189267414] 'process raft request' (duration: 1.011130962s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:48.513068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:47.501181Z","time spent":"1.011840149s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-31T17:24:48.513079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.778238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"warn","ts":"2026-05-31T17:24:48.513088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"756.507101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-05-31T17:24:48.513104Z","caller":"traceutil/trace.go:171","msg":"trace[1195739448] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1329; }","duration":"884.83632ms","start":"2026-05-31T17:24:47.62826Z","end":"2026-05-31T17:24:48.513097Z","steps":["trace[1195739448] 'agreement among raft nodes before linearized reading' (duration: 884.753478ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:24:48.513117Z","caller":"traceutil/trace.go:171","msg":"trace[105696670] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1329; }","duration":"756.597653ms","start":"2026-05-31T17:24:47.756509Z","end":"2026-05-31T17:24:48.513107Z","steps":["trace[105696670] 'agreement among raft nodes before linearized reading' (duration: 756.517561ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:48.513129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:47.628238Z","time spent":"884.885292ms","remote":"127.0.0.1:60546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":140,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"warn","ts":"2026-05-31T17:24:48.513133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.911069218s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-31T17:24:48.513143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:47.756482Z","time spent":"756.654825ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":557,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-05-31T17:24:48.513167Z","caller":"traceutil/trace.go:171","msg":"trace[2051724064] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1329; }","duration":"1.911137979s","start":"2026-05-31T17:24:46.602018Z","end":"2026-05-31T17:24:48.513156Z","steps":["trace[2051724064] 'agreement among raft nodes before linearized reading' (duration: 1.911076708s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:48.513199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:46.602Z","time spent":"1.91119428s","remote":"127.0.0.1:60480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-31T17:24:48.513799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.358014744s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-31T17:24:48.51385Z","caller":"traceutil/trace.go:171","msg":"trace[1944690586] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1329; }","duration":"2.358106806s","start":"2026-05-31T17:24:46.155732Z","end":"2026-05-31T17:24:48.513839Z","steps":["trace[1944690586] 'agreement among raft nodes before linearized reading' (duration: 2.3569903s)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:48.513882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:24:46.155715Z","time spent":"2.358160587s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-31T17:24:54.684858Z","caller":"traceutil/trace.go:171","msg":"trace[1954625059] linearizableReadLoop","detail":"{readStateIndex:1414; appliedIndex:1413; }","duration":"122.258137ms","start":"2026-05-31T17:24:54.56258Z","end":"2026-05-31T17:24:54.684839Z","steps":["trace[1954625059] 'read index received' (duration: 122.124454ms)","trace[1954625059] 'applied index is now lower than readState.Index' (duration: 132.943µs)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:24:54.684902Z","caller":"traceutil/trace.go:171","msg":"trace[1772311154] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"131.796742ms","start":"2026-05-31T17:24:54.553079Z","end":"2026-05-31T17:24:54.684876Z","steps":["trace[1772311154] 'process raft request' (duration: 131.665459ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:54.685138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.532203ms","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-05-31T17:24:54.68519Z","caller":"traceutil/trace.go:171","msg":"trace[974053290] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1358; }","duration":"122.612256ms","start":"2026-05-31T17:24:54.562564Z","end":"2026-05-31T17:24:54.685176Z","steps":["trace[974053290] 'agreement among raft nodes before linearized reading' (duration: 122.428321ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:54.685216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.24682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"warn","ts":"2026-05-31T17:24:54.68524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.81435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-31T17:24:54.685282Z","caller":"traceutil/trace.go:171","msg":"trace[456231673] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1358; }","duration":"120.347552ms","start":"2026-05-31T17:24:54.564918Z","end":"2026-05-31T17:24:54.685266Z","steps":["trace[456231673] 'agreement among raft nodes before linearized reading' (duration: 120.162357ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:24:54.685344Z","caller":"traceutil/trace.go:171","msg":"trace[1891775877] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1358; }","duration":"119.880131ms","start":"2026-05-31T17:24:54.565395Z","end":"2026-05-31T17:24:54.685275Z","steps":["trace[1891775877] 'agreement among raft nodes before linearized reading' (duration: 119.736818ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:54.685371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.581597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-31T17:24:54.685408Z","caller":"traceutil/trace.go:171","msg":"trace[1784417448] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1358; }","duration":"120.630559ms","start":"2026-05-31T17:24:54.564766Z","end":"2026-05-31T17:24:54.685397Z","steps":["trace[1784417448] 'agreement among raft nodes before linearized reading' (duration: 120.528156ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:24:54.685457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.572601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-31T17:24:54.685599Z","caller":"traceutil/trace.go:171","msg":"trace[1604311215] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1358; }","duration":"121.803996ms","start":"2026-05-31T17:24:54.563771Z","end":"2026-05-31T17:24:54.685575Z","steps":["trace[1604311215] 'agreement among raft nodes before linearized reading' (duration: 121.274944ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:24:57.126088Z","caller":"traceutil/trace.go:171","msg":"trace[1217418487] transaction","detail":"{read_only:false; response_revision:1373; number_of_response:1; }","duration":"116.251866ms","start":"2026-05-31T17:24:57.009812Z","end":"2026-05-31T17:24:57.126064Z","steps":["trace[1217418487] 'process raft request' (duration: 116.098502ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:25:09.262793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.621488ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-31T17:25:09.262894Z","caller":"traceutil/trace.go:171","msg":"trace[619260798] linearizableReadLoop","detail":"{readStateIndex:1486; appliedIndex:1485; }","duration":"276.468985ms","start":"2026-05-31T17:25:08.986409Z","end":"2026-05-31T17:25:09.262878Z","steps":["trace[619260798] 'read index received' (duration: 36.638212ms)","trace[619260798] 'applied index is now lower than readState.Index' (duration: 239.829523ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:25:09.26322Z","caller":"traceutil/trace.go:171","msg":"trace[1539908206] transaction","detail":"{read_only:false; response_revision:1427; number_of_response:1; }","duration":"299.709192ms","start":"2026-05-31T17:25:08.963477Z","end":"2026-05-31T17:25:09.263186Z","steps":["trace[1539908206] 'process raft request' (duration: 59.610993ms)","trace[1539908206] 'compare' (duration: 239.314261ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T17:25:09.263445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.847851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-31T17:25:09.263599Z","caller":"traceutil/trace.go:171","msg":"trace[2071620188] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1427; }","duration":"299.089828ms","start":"2026-05-31T17:25:08.964473Z","end":"2026-05-31T17:25:09.263562Z","steps":["trace[2071620188] 'agreement among raft nodes before linearized reading' (duration: 298.708889ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:25:09.311069Z","caller":"traceutil/trace.go:171","msg":"trace[1175629380] transaction","detail":"{read_only:false; response_revision:1428; number_of_response:1; }","duration":"320.799918ms","start":"2026-05-31T17:25:08.990232Z","end":"2026-05-31T17:25:09.311032Z","steps":["trace[1175629380] 'process raft request' (duration: 320.576493ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:25:09.311246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T17:25:08.990212Z","time spent":"320.941802ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-31T17:25:09.470517Z","caller":"traceutil/trace.go:171","msg":"trace[1177417861] transaction","detail":"{read_only:false; response_revision:1429; number_of_response:1; }","duration":"201.793569ms","start":"2026-05-31T17:25:09.268697Z","end":"2026-05-31T17:25:09.47049Z","steps":["trace[1177417861] 'process raft request' (duration: 201.641015ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:25:09.480528Z","caller":"traceutil/trace.go:171","msg":"trace[1702903592] transaction","detail":"{read_only:false; response_revision:1430; number_of_response:1; }","duration":"165.056074ms","start":"2026-05-31T17:25:09.315435Z","end":"2026-05-31T17:25:09.480491Z","steps":["trace[1702903592] 'process raft request' (duration: 164.880379ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:25:14.813798Z","caller":"traceutil/trace.go:171","msg":"trace[515902477] transaction","detail":"{read_only:false; response_revision:1450; number_of_response:1; }","duration":"102.900071ms","start":"2026-05-31T17:25:14.710867Z","end":"2026-05-31T17:25:14.813767Z","steps":["trace[515902477] 'process raft request' (duration: 102.712587ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:25:47.347361Z","caller":"traceutil/trace.go:171","msg":"trace[1485028043] transaction","detail":"{read_only:false; response_revision:1599; number_of_response:1; }","duration":"167.504286ms","start":"2026-05-31T17:25:47.179822Z","end":"2026-05-31T17:25:47.347326Z","steps":["trace[1485028043] 'process raft request' (duration: 150.367694ms)","trace[1485028043] 'compare' (duration: 16.857035ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:25:49.001403Z","caller":"traceutil/trace.go:171","msg":"trace[1521628210] transaction","detail":"{read_only:false; response_revision:1605; number_of_response:1; }","duration":"128.540833ms","start":"2026-05-31T17:25:48.872835Z","end":"2026-05-31T17:25:49.001376Z","steps":["trace[1521628210] 'process raft request' (duration: 128.4019ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:25:49.102745Z","caller":"traceutil/trace.go:171","msg":"trace[1732070494] transaction","detail":"{read_only:false; response_revision:1606; number_of_response:1; }","duration":"149.562606ms","start":"2026-05-31T17:25:48.953146Z","end":"2026-05-31T17:25:49.102709Z","steps":["trace[1732070494] 'process raft request' (duration: 81.284945ms)","trace[1732070494] 'compare' (duration: 68.152078ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:25:49.73909Z","caller":"traceutil/trace.go:171","msg":"trace[1076165280] transaction","detail":"{read_only:false; response_revision:1613; number_of_response:1; }","duration":"127.12234ms","start":"2026-05-31T17:25:49.611937Z","end":"2026-05-31T17:25:49.73906Z","steps":["trace[1076165280] 'process raft request' (duration: 105.290668ms)","trace[1076165280] 'compare' (duration: 21.587526ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:26:45.575512Z","caller":"traceutil/trace.go:171","msg":"trace[1671318949] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"194.569715ms","start":"2026-05-31T17:26:45.380912Z","end":"2026-05-31T17:26:45.575482Z","steps":["trace[1671318949] 'process raft request' (duration: 189.949857ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:26:45.679907Z","caller":"traceutil/trace.go:171","msg":"trace[756019639] linearizableReadLoop","detail":"{readStateIndex:1944; appliedIndex:1942; }","duration":"136.190928ms","start":"2026-05-31T17:26:45.543688Z","end":"2026-05-31T17:26:45.679878Z","steps":["trace[756019639] 'read index received' (duration: 27.183486ms)","trace[756019639] 'applied index is now lower than readState.Index' (duration: 109.005772ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T17:26:45.680507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.794232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-31T17:26:45.680595Z","caller":"traceutil/trace.go:171","msg":"trace[1051074907] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1865; }","duration":"136.921555ms","start":"2026-05-31T17:26:45.543651Z","end":"2026-05-31T17:26:45.680573Z","steps":["trace[1051074907] 'agreement among raft nodes before linearized reading' (duration: 136.370373ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:26:45.866529Z","caller":"traceutil/trace.go:171","msg":"trace[648579657] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"104.879235ms","start":"2026-05-31T17:26:45.761624Z","end":"2026-05-31T17:26:45.866503Z","steps":["trace[648579657] 'process raft request' (duration: 37.112289ms)","trace[648579657] 'compare' (duration: 67.5283ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T17:27:02.085207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.966209ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-31T17:27:02.085281Z","caller":"traceutil/trace.go:171","msg":"trace[999633369] linearizableReadLoop","detail":"{readStateIndex:2024; appliedIndex:2023; }","duration":"146.254034ms","start":"2026-05-31T17:27:01.939015Z","end":"2026-05-31T17:27:02.085269Z","steps":["trace[999633369] 'read index received' (duration: 49.451µs)","trace[999633369] 'applied index is now lower than readState.Index' (duration: 146.203623ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T17:27:02.085395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.385077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-31T17:27:02.085413Z","caller":"traceutil/trace.go:171","msg":"trace[1853544196] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1942; }","duration":"146.434428ms","start":"2026-05-31T17:27:01.938974Z","end":"2026-05-31T17:27:02.085409Z","steps":["trace[1853544196] 'agreement among raft nodes before linearized reading' (duration: 146.324106ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:27:02.085533Z","caller":"traceutil/trace.go:171","msg":"trace[557743445] transaction","detail":"{read_only:false; response_revision:1942; number_of_response:1; }","duration":"234.078339ms","start":"2026-05-31T17:27:01.851369Z","end":"2026-05-31T17:27:02.085447Z","steps":["trace[557743445] 'process raft request' (duration: 60.828484ms)","trace[557743445] 'compare' (duration: 172.755514ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T17:27:20.304736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.700447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-31T17:27:20.304839Z","caller":"traceutil/trace.go:171","msg":"trace[1007130102] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:2025; }","duration":"100.859932ms","start":"2026-05-31T17:27:20.203961Z","end":"2026-05-31T17:27:20.304821Z","steps":["trace[1007130102] 'agreement among raft nodes before linearized reading' (duration: 99.221263ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:28:38.832242Z","caller":"traceutil/trace.go:171","msg":"trace[1137463710] transaction","detail":"{read_only:false; response_revision:2409; number_of_response:1; }","duration":"106.518974ms","start":"2026-05-31T17:28:38.725688Z","end":"2026-05-31T17:28:38.832207Z","steps":["trace[1137463710] 'process raft request' (duration: 106.250917ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:28:39.118981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.564613ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-31T17:28:39.119089Z","caller":"traceutil/trace.go:171","msg":"trace[299074603] transaction","detail":"{read_only:false; response_revision:2410; number_of_response:1; }","duration":"282.30837ms","start":"2026-05-31T17:28:38.83677Z","end":"2026-05-31T17:28:39.119078Z","steps":["trace[299074603] 'process raft request' (duration: 38.591933ms)","trace[299074603] 'compare' (duration: 243.41884ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:28:39.119403Z","caller":"traceutil/trace.go:171","msg":"trace[1621966459] transaction","detail":"{read_only:false; response_revision:2411; number_of_response:1; }","duration":"282.266899ms","start":"2026-05-31T17:28:38.837125Z","end":"2026-05-31T17:28:39.119392Z","steps":["trace[1621966459] 'process raft request' (duration: 281.928501ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:28:39.119892Z","caller":"traceutil/trace.go:171","msg":"trace[1890415342] transaction","detail":"{read_only:false; response_revision:2412; number_of_response:1; }","duration":"281.006339ms","start":"2026-05-31T17:28:38.838875Z","end":"2026-05-31T17:28:39.119881Z","steps":["trace[1890415342] 'process raft request' (duration: 280.62654ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T17:28:39.119855Z","caller":"traceutil/trace.go:171","msg":"trace[1126824125] linearizableReadLoop","detail":"{readStateIndex:2515; appliedIndex:2511; }","duration":"258.179255ms","start":"2026-05-31T17:28:38.861652Z","end":"2026-05-31T17:28:39.119831Z","steps":["trace[1126824125] 'read index received' (duration: 13.708381ms)","trace[1126824125] 'applied index is now lower than readState.Index' (duration: 244.469804ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T17:28:39.119965Z","caller":"traceutil/trace.go:171","msg":"trace[1922336794] transaction","detail":"{read_only:false; response_revision:2413; number_of_response:1; }","duration":"280.212061ms","start":"2026-05-31T17:28:38.839747Z","end":"2026-05-31T17:28:39.11996Z","steps":["trace[1922336794] 'process raft request' (duration: 280.040397ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T17:28:39.119989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.325688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-31T17:28:39.120067Z","caller":"traceutil/trace.go:171","msg":"trace[208200949] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:2413; }","duration":"258.4184ms","start":"2026-05-31T17:28:38.861634Z","end":"2026-05-31T17:28:39.120052Z","steps":["trace[208200949] 'agreement among raft nodes before linearized reading' (duration: 258.280667ms)"],"step_count":1}