{"level":"warn","ts":"2026-03-31T18:21:06.043387Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-31T18:21:06.04347Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.102: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.102:2380","--initial-cluster=instance=https://199.204.45.102:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.102:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.102: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-03-31T18:21:06.043563Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-31T18:21:06.043589Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.102:2380"]} {"level":"info","ts":"2026-03-31T18:21:06.043628Z","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-03-31T18:21:06.044239Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.102:2379"]} {"level":"info","ts":"2026-03-31T18:21:06.044347Z","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.102:2380"],"listen-peer-urls":["https://199.204.45.102:2380"],"advertise-client-urls":["https://199.204.45.102:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.102:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.102: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-03-31T18:21:06.049133Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.491014ms"} {"level":"info","ts":"2026-03-31T18:21:06.055628Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6e7960f761c1028e","cluster-id":"502e2b31b867adf"} {"level":"info","ts":"2026-03-31T18:21:06.055778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e switched to configuration voters=()"} {"level":"info","ts":"2026-03-31T18:21:06.055831Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e became follower at term 0"} {"level":"info","ts":"2026-03-31T18:21:06.05586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6e7960f761c1028e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-31T18:21:06.055907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e became follower at term 1"} {"level":"info","ts":"2026-03-31T18:21:06.055993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e switched to configuration voters=(7960500431967289998)"} {"level":"warn","ts":"2026-03-31T18:21:06.062302Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-31T18:21:06.064097Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-31T18:21:06.066661Z","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-03-31T18:21:06.069932Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6e7960f761c1028e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-31T18:21:06.070585Z","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-03-31T18:21:06.070694Z","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-03-31T18:21:06.070708Z","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-03-31T18:21:06.070912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e switched to configuration voters=(7960500431967289998)"} {"level":"info","ts":"2026-03-31T18:21:06.070876Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6e7960f761c1028e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-31T18:21:06.071618Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"502e2b31b867adf","local-member-id":"6e7960f761c1028e","added-peer-id":"6e7960f761c1028e","added-peer-peer-urls":["https://199.204.45.102:2380"]} {"level":"info","ts":"2026-03-31T18:21:06.075788Z","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-03-31T18:21:06.075938Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.102:2380"} {"level":"info","ts":"2026-03-31T18:21:06.076141Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.102:2380"} {"level":"info","ts":"2026-03-31T18:21:06.076025Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6e7960f761c1028e","initial-advertise-peer-urls":["https://199.204.45.102:2380"],"listen-peer-urls":["https://199.204.45.102:2380"],"advertise-client-urls":["https://199.204.45.102:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.102:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-31T18:21:06.076082Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-31T18:21:07.056618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e is starting a new election at term 1"} {"level":"info","ts":"2026-03-31T18:21:07.056676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e became pre-candidate at term 1"} {"level":"info","ts":"2026-03-31T18:21:07.056718Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e received MsgPreVoteResp from 6e7960f761c1028e at term 1"} {"level":"info","ts":"2026-03-31T18:21:07.056734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e became candidate at term 2"} {"level":"info","ts":"2026-03-31T18:21:07.056742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e received MsgVoteResp from 6e7960f761c1028e at term 2"} {"level":"info","ts":"2026-03-31T18:21:07.056756Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e became leader at term 2"} {"level":"info","ts":"2026-03-31T18:21:07.056766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6e7960f761c1028e elected leader 6e7960f761c1028e at term 2"} {"level":"info","ts":"2026-03-31T18:21:07.057455Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T18:21:07.060698Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-31T18:21:07.060703Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6e7960f761c1028e","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.102:2379]}","request-path":"/0/members/6e7960f761c1028e/attributes","cluster-id":"502e2b31b867adf","publish-timeout":"7s"} {"level":"info","ts":"2026-03-31T18:21:07.060954Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-31T18:21:07.062205Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"502e2b31b867adf","local-member-id":"6e7960f761c1028e","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T18:21:07.062331Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T18:21:07.06237Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T18:21:07.062656Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-31T18:21:07.062724Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-31T18:21:07.063029Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-31T18:21:07.063103Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.102:2379"} {"level":"warn","ts":"2026-03-31T18:21:08.54896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.737429ms","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-03-31T18:21:08.549076Z","caller":"traceutil/trace.go:171","msg":"trace[1891473959] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:12; }","duration":"162.879442ms","start":"2026-03-31T18:21:08.386169Z","end":"2026-03-31T18:21:08.549048Z","steps":["trace[1891473959] 'agreement among raft nodes before linearized reading' (duration: 162.703088ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:08.549181Z","caller":"traceutil/trace.go:171","msg":"trace[1883781266] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"158.157985ms","start":"2026-03-31T18:21:08.39099Z","end":"2026-03-31T18:21:08.549148Z","steps":["trace[1883781266] 'process raft request' (duration: 104.232516ms)","trace[1883781266] 'compare' (duration: 53.439618ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:21:08.54944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.852972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-31T18:21:08.549504Z","caller":"traceutil/trace.go:171","msg":"trace[1451727500] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"140.767788ms","start":"2026-03-31T18:21:08.408719Z","end":"2026-03-31T18:21:08.549487Z","steps":["trace[1451727500] 'process raft request' (duration: 140.076242ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:08.549539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.856482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-31T18:21:08.549558Z","caller":"traceutil/trace.go:171","msg":"trace[337103759] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"163.041106ms","start":"2026-03-31T18:21:08.386498Z","end":"2026-03-31T18:21:08.54954Z","steps":["trace[337103759] 'agreement among raft nodes before linearized reading' (duration: 162.832062ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:08.549591Z","caller":"traceutil/trace.go:171","msg":"trace[631294509] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"162.904803ms","start":"2026-03-31T18:21:08.386668Z","end":"2026-03-31T18:21:08.549573Z","steps":["trace[631294509] 'agreement among raft nodes before linearized reading' (duration: 162.834151ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:08.549906Z","caller":"traceutil/trace.go:171","msg":"trace[1224392182] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"136.085862ms","start":"2026-03-31T18:21:08.413805Z","end":"2026-03-31T18:21:08.54989Z","steps":["trace[1224392182] 'process raft request' (duration: 135.027788ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:08.549973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.656512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-03-31T18:21:08.54996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.18635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-31T18:21:08.550005Z","caller":"traceutil/trace.go:171","msg":"trace[437484442] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:12; }","duration":"160.714643ms","start":"2026-03-31T18:21:08.389281Z","end":"2026-03-31T18:21:08.549996Z","steps":["trace[437484442] 'agreement among raft nodes before linearized reading' (duration: 160.655181ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:08.550025Z","caller":"traceutil/trace.go:171","msg":"trace[1373813543] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"113.290372ms","start":"2026-03-31T18:21:08.436719Z","end":"2026-03-31T18:21:08.550009Z","steps":["trace[1373813543] 'agreement among raft nodes before linearized reading' (duration: 113.18431ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:08.576372Z","caller":"traceutil/trace.go:171","msg":"trace[584685649] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"109.710961ms","start":"2026-03-31T18:21:08.466637Z","end":"2026-03-31T18:21:08.576348Z","steps":["trace[584685649] 'process raft request' (duration: 109.496586ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:08.576453Z","caller":"traceutil/trace.go:171","msg":"trace[1990140401] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"109.385544ms","start":"2026-03-31T18:21:08.46706Z","end":"2026-03-31T18:21:08.576446Z","steps":["trace[1990140401] 'process raft request' (duration: 109.23099ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:08.576424Z","caller":"traceutil/trace.go:171","msg":"trace[482221318] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"109.726661ms","start":"2026-03-31T18:21:08.46664Z","end":"2026-03-31T18:21:08.576367Z","steps":["trace[482221318] 'process raft request' (duration: 109.613478ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:08.576402Z","caller":"traceutil/trace.go:171","msg":"trace[2004690120] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"109.148918ms","start":"2026-03-31T18:21:08.467233Z","end":"2026-03-31T18:21:08.576382Z","steps":["trace[2004690120] 'process raft request' (duration: 109.119918ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:08.576534Z","caller":"traceutil/trace.go:171","msg":"trace[534843073] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"109.315882ms","start":"2026-03-31T18:21:08.467212Z","end":"2026-03-31T18:21:08.576528Z","steps":["trace[534843073] 'process raft request' (duration: 109.116577ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:08.758677Z","caller":"traceutil/trace.go:171","msg":"trace[473120193] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"178.895898ms","start":"2026-03-31T18:21:08.579715Z","end":"2026-03-31T18:21:08.758611Z","steps":["trace[473120193] 'process raft request' (duration: 110.227492ms)","trace[473120193] 'compare' (duration: 68.40712ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:08.758697Z","caller":"traceutil/trace.go:171","msg":"trace[1897963412] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"178.634632ms","start":"2026-03-31T18:21:08.580028Z","end":"2026-03-31T18:21:08.758662Z","steps":["trace[1897963412] 'process raft request' (duration: 178.443258ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:08.758794Z","caller":"traceutil/trace.go:171","msg":"trace[817817189] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"178.741724ms","start":"2026-03-31T18:21:08.580043Z","end":"2026-03-31T18:21:08.758785Z","steps":["trace[817817189] 'process raft request' (duration: 178.471598ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:08.758791Z","caller":"traceutil/trace.go:171","msg":"trace[967970958] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"136.767497ms","start":"2026-03-31T18:21:08.622002Z","end":"2026-03-31T18:21:08.75877Z","steps":["trace[967970958] 'process raft request' (duration: 136.721216ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:08.758746Z","caller":"traceutil/trace.go:171","msg":"trace[374299744] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"178.636641ms","start":"2026-03-31T18:21:08.580087Z","end":"2026-03-31T18:21:08.758724Z","steps":["trace[374299744] 'process raft request' (duration: 178.535729ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:08.758918Z","caller":"traceutil/trace.go:171","msg":"trace[194006776] linearizableReadLoop","detail":"{readStateIndex:29; appliedIndex:24; }","duration":"140.232386ms","start":"2026-03-31T18:21:08.618668Z","end":"2026-03-31T18:21:08.7589Z","steps":["trace[194006776] 'read index received' (duration: 71.268614ms)","trace[194006776] 'applied index is now lower than readState.Index' (duration: 68.950372ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:21:08.759076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.463751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-03-31T18:21:08.759121Z","caller":"traceutil/trace.go:171","msg":"trace[1185402222] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:26; }","duration":"147.546413ms","start":"2026-03-31T18:21:08.611564Z","end":"2026-03-31T18:21:08.75911Z","steps":["trace[1185402222] 'agreement among raft nodes before linearized reading' (duration: 147.338739ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:08.759128Z","caller":"traceutil/trace.go:171","msg":"trace[1255516999] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"178.968009ms","start":"2026-03-31T18:21:08.580145Z","end":"2026-03-31T18:21:08.759113Z","steps":["trace[1255516999] 'process raft request' (duration: 178.513059ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:08.759156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.826861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"warn","ts":"2026-03-31T18:21:08.759189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.361737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-03-31T18:21:08.75923Z","caller":"traceutil/trace.go:171","msg":"trace[1924009854] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:26; }","duration":"205.875722ms","start":"2026-03-31T18:21:08.55331Z","end":"2026-03-31T18:21:08.759185Z","steps":["trace[1924009854] 'agreement among raft nodes before linearized reading' (duration: 205.79279ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:08.759255Z","caller":"traceutil/trace.go:171","msg":"trace[1215607037] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:26; }","duration":"139.448378ms","start":"2026-03-31T18:21:08.619791Z","end":"2026-03-31T18:21:08.759239Z","steps":["trace[1215607037] 'agreement among raft nodes before linearized reading' (duration: 139.335656ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:08.759263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.264588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-31T18:21:08.759302Z","caller":"traceutil/trace.go:171","msg":"trace[408833050] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:26; }","duration":"137.33273ms","start":"2026-03-31T18:21:08.621954Z","end":"2026-03-31T18:21:08.759287Z","steps":["trace[408833050] 'agreement among raft nodes before linearized reading' (duration: 137.264539ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:08.759072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.812042ms","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-03-31T18:21:08.759454Z","caller":"traceutil/trace.go:171","msg":"trace[222736759] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:26; }","duration":"192.235182ms","start":"2026-03-31T18:21:08.567203Z","end":"2026-03-31T18:21:08.759438Z","steps":["trace[222736759] 'agreement among raft nodes before linearized reading' (duration: 191.803862ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:09.668077Z","caller":"traceutil/trace.go:171","msg":"trace[1717955040] transaction","detail":"{read_only:false; response_revision:89; number_of_response:1; }","duration":"115.716605ms","start":"2026-03-31T18:21:09.552331Z","end":"2026-03-31T18:21:09.668048Z","steps":["trace[1717955040] 'process raft request' (duration: 43.990264ms)","trace[1717955040] 'compare' (duration: 71.583227ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:10.35338Z","caller":"traceutil/trace.go:171","msg":"trace[927682640] transaction","detail":"{read_only:false; response_revision:109; number_of_response:1; }","duration":"288.952892ms","start":"2026-03-31T18:21:10.0644Z","end":"2026-03-31T18:21:10.353353Z","steps":["trace[927682640] 'process raft request' (duration: 270.807606ms)","trace[927682640] 'compare' (duration: 17.994693ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:10.54182Z","caller":"traceutil/trace.go:171","msg":"trace[1674301953] transaction","detail":"{read_only:false; response_revision:114; number_of_response:1; }","duration":"105.199426ms","start":"2026-03-31T18:21:10.436586Z","end":"2026-03-31T18:21:10.541785Z","steps":["trace[1674301953] 'process raft request' (duration: 28.444247ms)","trace[1674301953] 'compare' (duration: 76.603476ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:12.154158Z","caller":"traceutil/trace.go:171","msg":"trace[2046097404] transaction","detail":"{read_only:false; response_revision:230; number_of_response:1; }","duration":"104.839958ms","start":"2026-03-31T18:21:12.049277Z","end":"2026-03-31T18:21:12.154117Z","steps":["trace[2046097404] 'process raft request' (duration: 91.047824ms)","trace[2046097404] 'compare' (duration: 13.483097ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:12.681427Z","caller":"traceutil/trace.go:171","msg":"trace[1609739094] transaction","detail":"{read_only:false; response_revision:247; number_of_response:1; }","duration":"153.896139ms","start":"2026-03-31T18:21:12.527504Z","end":"2026-03-31T18:21:12.6814Z","steps":["trace[1609739094] 'process raft request' (duration: 153.755436ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:12.808021Z","caller":"traceutil/trace.go:171","msg":"trace[199509849] transaction","detail":"{read_only:false; response_revision:251; number_of_response:1; }","duration":"112.307844ms","start":"2026-03-31T18:21:12.695689Z","end":"2026-03-31T18:21:12.807997Z","steps":["trace[199509849] 'process raft request' (duration: 87.475837ms)","trace[199509849] 'compare' (duration: 24.585401ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:12.808315Z","caller":"traceutil/trace.go:171","msg":"trace[90656664] transaction","detail":"{read_only:false; response_revision:252; number_of_response:1; }","duration":"110.035323ms","start":"2026-03-31T18:21:12.698269Z","end":"2026-03-31T18:21:12.808305Z","steps":["trace[90656664] 'process raft request' (duration: 109.615734ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:13.624483Z","caller":"traceutil/trace.go:171","msg":"trace[1144947622] transaction","detail":"{read_only:false; response_revision:290; number_of_response:1; }","duration":"130.676634ms","start":"2026-03-31T18:21:13.493782Z","end":"2026-03-31T18:21:13.624459Z","steps":["trace[1144947622] 'process raft request' (duration: 73.496505ms)","trace[1144947622] 'compare' (duration: 57.083087ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:13.627181Z","caller":"traceutil/trace.go:171","msg":"trace[591575282] linearizableReadLoop","detail":"{readStateIndex:297; appliedIndex:295; }","duration":"129.423657ms","start":"2026-03-31T18:21:13.497725Z","end":"2026-03-31T18:21:13.627148Z","steps":["trace[591575282] 'read index received' (duration: 69.57018ms)","trace[591575282] 'applied index is now lower than readState.Index' (duration: 59.852237ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:13.627333Z","caller":"traceutil/trace.go:171","msg":"trace[137192200] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"126.501723ms","start":"2026-03-31T18:21:13.500819Z","end":"2026-03-31T18:21:13.62732Z","steps":["trace[137192200] 'process raft request' (duration: 126.240617ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:13.627375Z","caller":"traceutil/trace.go:171","msg":"trace[240418108] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"129.572729ms","start":"2026-03-31T18:21:13.49779Z","end":"2026-03-31T18:21:13.627362Z","steps":["trace[240418108] 'process raft request' (duration: 129.211572ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:13.627295Z","caller":"traceutil/trace.go:171","msg":"trace[1977268511] transaction","detail":"{read_only:false; response_revision:291; number_of_response:1; }","duration":"130.106081ms","start":"2026-03-31T18:21:13.49715Z","end":"2026-03-31T18:21:13.627256Z","steps":["trace[1977268511] 'process raft request' (duration: 129.730913ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:13.627818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.071161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-03-31T18:21:13.627862Z","caller":"traceutil/trace.go:171","msg":"trace[1339822657] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:293; }","duration":"130.141422ms","start":"2026-03-31T18:21:13.497706Z","end":"2026-03-31T18:21:13.627847Z","steps":["trace[1339822657] 'agreement among raft nodes before linearized reading' (duration: 129.958258ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:13.649043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.325023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-03-31T18:21:13.649255Z","caller":"traceutil/trace.go:171","msg":"trace[334149209] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:297; }","duration":"112.517787ms","start":"2026-03-31T18:21:13.536685Z","end":"2026-03-31T18:21:13.649203Z","steps":["trace[334149209] 'agreement among raft nodes before linearized reading' (duration: 112.257672ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:13.985738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.659317ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:21:13.985928Z","caller":"traceutil/trace.go:171","msg":"trace[1530420166] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"330.996457ms","start":"2026-03-31T18:21:13.654916Z","end":"2026-03-31T18:21:13.985912Z","steps":["trace[1530420166] 'process raft request' (duration: 330.952116ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:13.985996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:13.654898Z","time spent":"331.071268ms","remote":"127.0.0.1:37268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1196,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-31T18:21:13.986041Z","caller":"traceutil/trace.go:171","msg":"trace[494419947] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"333.268416ms","start":"2026-03-31T18:21:13.652738Z","end":"2026-03-31T18:21:13.986007Z","steps":["trace[494419947] 'process raft request' (duration: 123.957125ms)","trace[494419947] 'compare' (duration: 208.548405ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:13.986097Z","caller":"traceutil/trace.go:171","msg":"trace[2121951445] linearizableReadLoop","detail":"{readStateIndex:310; appliedIndex:307; }","duration":"333.195745ms","start":"2026-03-31T18:21:13.652854Z","end":"2026-03-31T18:21:13.98605Z","steps":["trace[2121951445] 'read index received' (duration: 909.23µs)","trace[2121951445] 'applied index is now lower than readState.Index' (duration: 332.283715ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:21:13.986167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:13.65271Z","time spent":"333.41407ms","remote":"127.0.0.1:37280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":199,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-31T18:21:13.986258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.402009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-03-31T18:21:13.986317Z","caller":"traceutil/trace.go:171","msg":"trace[1904825287] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:303; }","duration":"333.507752ms","start":"2026-03-31T18:21:13.652793Z","end":"2026-03-31T18:21:13.986301Z","steps":["trace[1904825287] 'agreement among raft nodes before linearized reading' (duration: 333.372349ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:13.986362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:13.652767Z","time spent":"333.583924ms","remote":"127.0.0.1:37246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4039,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-03-31T18:21:13.986019Z","caller":"traceutil/trace.go:171","msg":"trace[1802179442] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"333.105153ms","start":"2026-03-31T18:21:13.652834Z","end":"2026-03-31T18:21:13.98594Z","steps":["trace[1802179442] 'process raft request' (duration: 332.97519ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:13.987037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:13.652824Z","time spent":"334.145016ms","remote":"127.0.0.1:37136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":638,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-31T18:21:19.316145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"974.521279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-03-31T18:21:19.316197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.291951541s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4369"} {"level":"info","ts":"2026-03-31T18:21:19.316293Z","caller":"traceutil/trace.go:171","msg":"trace[1490388823] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:391; }","duration":"1.292089034s","start":"2026-03-31T18:21:18.024183Z","end":"2026-03-31T18:21:19.316272Z","steps":["trace[1490388823] 'range keys from in-memory index tree' (duration: 1.29185585s)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:19.316292Z","caller":"traceutil/trace.go:171","msg":"trace[1060550644] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:391; }","duration":"974.709773ms","start":"2026-03-31T18:21:18.341555Z","end":"2026-03-31T18:21:19.316264Z","steps":["trace[1060550644] 'range keys from in-memory index tree' (duration: 974.367576ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:19.316335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:18.024165Z","time spent":"1.292159765s","remote":"127.0.0.1:37246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4391,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-03-31T18:21:19.31635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:18.341537Z","time spent":"974.799545ms","remote":"127.0.0.1:37330","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":"warn","ts":"2026-03-31T18:21:19.496127Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":184257554996169577,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-31T18:21:19.893152Z","caller":"traceutil/trace.go:171","msg":"trace[767047921] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"959.824474ms","start":"2026-03-31T18:21:18.933309Z","end":"2026-03-31T18:21:19.893133Z","steps":["trace[767047921] 'process raft request' (duration: 959.692121ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:19.893261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:18.93329Z","time spent":"959.922426ms","remote":"127.0.0.1:37136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-31T18:21:19.903016Z","caller":"traceutil/trace.go:171","msg":"trace[2068761344] linearizableReadLoop","detail":"{readStateIndex:404; appliedIndex:401; }","duration":"907.335623ms","start":"2026-03-31T18:21:18.995658Z","end":"2026-03-31T18:21:19.902994Z","steps":["trace[2068761344] 'read index received' (duration: 897.375666ms)","trace[2068761344] 'applied index is now lower than readState.Index' (duration: 9.959367ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:19.903071Z","caller":"traceutil/trace.go:171","msg":"trace[241798804] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"582.729614ms","start":"2026-03-31T18:21:19.320297Z","end":"2026-03-31T18:21:19.903026Z","steps":["trace[241798804] 'process raft request' (duration: 582.629241ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:19.90322Z","caller":"traceutil/trace.go:171","msg":"trace[1248721916] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"961.974477ms","start":"2026-03-31T18:21:18.941225Z","end":"2026-03-31T18:21:19.9032Z","steps":["trace[1248721916] 'process raft request' (duration: 961.63372ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:19.903228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"907.573047ms","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-03-31T18:21:19.903314Z","caller":"traceutil/trace.go:171","msg":"trace[257063028] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:394; }","duration":"907.69999ms","start":"2026-03-31T18:21:18.995605Z","end":"2026-03-31T18:21:19.903305Z","steps":["trace[257063028] 'agreement among raft nodes before linearized reading' (duration: 907.589908ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:19.903348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.011924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-03-31T18:21:19.903352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:18.995584Z","time spent":"907.751751ms","remote":"127.0.0.1:37330","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-03-31T18:21:19.903386Z","caller":"traceutil/trace.go:171","msg":"trace[1222614530] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:394; }","duration":"170.057405ms","start":"2026-03-31T18:21:19.733314Z","end":"2026-03-31T18:21:19.903371Z","steps":["trace[1222614530] 'agreement among raft nodes before linearized reading' (duration: 169.989303ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:19.903389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.002399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-03-31T18:21:19.903466Z","caller":"traceutil/trace.go:171","msg":"trace[824838854] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:394; }","duration":"177.134212ms","start":"2026-03-31T18:21:19.726315Z","end":"2026-03-31T18:21:19.90345Z","steps":["trace[824838854] 'agreement among raft nodes before linearized reading' (duration: 176.971559ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:19.903485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:19.320271Z","time spent":"582.879006ms","remote":"127.0.0.1:37330","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-03-31T18:21:19.903571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:18.941208Z","time spent":"962.05954ms","remote":"127.0.0.1:37330","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-03-31T18:21:24.574057Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":184257554996169622,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-31T18:21:25.074229Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":184257554996169622,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-31T18:21:25.5748Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":184257554996169622,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-31T18:21:25.686111Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.228264741s","expected-duration":"1s"} {"level":"info","ts":"2026-03-31T18:21:25.686542Z","caller":"traceutil/trace.go:171","msg":"trace[1788835215] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"1.685266743s","start":"2026-03-31T18:21:24.001253Z","end":"2026-03-31T18:21:25.686519Z","steps":["trace[1788835215] 'process raft request' (duration: 1.68509831s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:25.686717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:24.00123Z","time spent":"1.685383076s","remote":"127.0.0.1:37260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7096,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:21:26.073694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000325641s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-03-31T18:21:26.073794Z","caller":"traceutil/trace.go:171","msg":"trace[1455750937] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000472043s","start":"2026-03-31T18:21:24.073304Z","end":"2026-03-31T18:21:26.073776Z","steps":["trace[1455750937] 'agreement among raft nodes before linearized reading' (duration: 2.000358621s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:26.073843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:24.073286Z","time spent":"2.000543225s","remote":"127.0.0.1:37070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/03/31 18:21:26 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-03-31T18:21:26.506048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.709476ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:21:26.506186Z","caller":"traceutil/trace.go:171","msg":"trace[2097671057] linearizableReadLoop","detail":"{readStateIndex:426; appliedIndex:424; }","duration":"2.432813861s","start":"2026-03-31T18:21:24.073356Z","end":"2026-03-31T18:21:26.50617Z","steps":["trace[2097671057] 'read index received' (duration: 1.612952898s)","trace[2097671057] 'applied index is now lower than readState.Index' (duration: 819.859783ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:26.506263Z","caller":"traceutil/trace.go:171","msg":"trace[654686844] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"2.500222148s","start":"2026-03-31T18:21:24.005992Z","end":"2026-03-31T18:21:26.506214Z","steps":["trace[654686844] 'process raft request' (duration: 1.896267737s)","trace[654686844] 'compare' (duration: 603.584894ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:21:26.506472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:24.005972Z","time spent":"2.500392502s","remote":"127.0.0.1:37330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:21:26.94096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000662854s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-03-31T18:21:26.941023Z","caller":"traceutil/trace.go:171","msg":"trace[784785494] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000766407s","start":"2026-03-31T18:21:24.940243Z","end":"2026-03-31T18:21:26.94101Z","steps":["trace[784785494] 'agreement among raft nodes before linearized reading' (duration: 2.000688385s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:26.941052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:24.940228Z","time spent":"2.000819327s","remote":"127.0.0.1:37062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/03/31 18:21:26 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-03-31T18:21:27.109117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.679987ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:21:27.1093Z","caller":"traceutil/trace.go:171","msg":"trace[2040363908] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"1.030821692s","start":"2026-03-31T18:21:26.078435Z","end":"2026-03-31T18:21:27.109257Z","steps":["trace[2040363908] 'process raft request' (duration: 559.91951ms)","trace[2040363908] 'compare' (duration: 470.498174ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:27.109373Z","caller":"traceutil/trace.go:171","msg":"trace[991380437] linearizableReadLoop","detail":"{readStateIndex:427; appliedIndex:426; }","duration":"603.133594ms","start":"2026-03-31T18:21:26.506211Z","end":"2026-03-31T18:21:27.109345Z","steps":["trace[991380437] 'read index received' (duration: 132.252923ms)","trace[991380437] 'applied index is now lower than readState.Index' (duration: 470.877521ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:21:27.109445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.125651011s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-03-31T18:21:27.109474Z","caller":"traceutil/trace.go:171","msg":"trace[1522497565] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:415; }","duration":"1.125717462s","start":"2026-03-31T18:21:25.983748Z","end":"2026-03-31T18:21:27.109466Z","steps":["trace[1522497565] 'agreement among raft nodes before linearized reading' (duration: 1.125607259s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:27.109468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:26.078412Z","time spent":"1.030970064s","remote":"127.0.0.1:37136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-31T18:21:27.109501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:25.983729Z","time spent":"1.125765643s","remote":"127.0.0.1:37330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-03-31T18:21:27.120186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.42885891s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"} {"level":"warn","ts":"2026-03-31T18:21:27.120251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.176907404s","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-03-31T18:21:27.120268Z","caller":"traceutil/trace.go:171","msg":"trace[278230762] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:415; }","duration":"1.428986503s","start":"2026-03-31T18:21:25.691266Z","end":"2026-03-31T18:21:27.120253Z","steps":["trace[278230762] 'agreement among raft nodes before linearized reading' (duration: 1.418167452s)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:27.120293Z","caller":"traceutil/trace.go:171","msg":"trace[792470766] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:415; }","duration":"1.176976155s","start":"2026-03-31T18:21:25.943304Z","end":"2026-03-31T18:21:27.12028Z","steps":["trace[792470766] 'agreement among raft nodes before linearized reading' (duration: 1.166150923s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:27.12033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:25.943284Z","time spent":"1.177036316s","remote":"127.0.0.1:37330","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":"warn","ts":"2026-03-31T18:21:27.120306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:25.691246Z","time spent":"1.429052274s","remote":"127.0.0.1:37260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6987,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"warn","ts":"2026-03-31T18:21:27.120463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.125382432s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-03-31T18:21:27.120538Z","caller":"traceutil/trace.go:171","msg":"trace[2129696746] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:415; }","duration":"1.125480883s","start":"2026-03-31T18:21:25.995042Z","end":"2026-03-31T18:21:27.120523Z","steps":["trace[2129696746] 'agreement among raft nodes before linearized reading' (duration: 1.114434188s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:27.120603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.148307936s","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-03-31T18:21:27.120638Z","caller":"traceutil/trace.go:171","msg":"trace[664671616] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:415; }","duration":"1.148381707s","start":"2026-03-31T18:21:25.972249Z","end":"2026-03-31T18:21:27.12063Z","steps":["trace[664671616] 'agreement among raft nodes before linearized reading' (duration: 1.137205499s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:27.120665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:25.972227Z","time spent":"1.148430349s","remote":"127.0.0.1:37330","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-03-31T18:21:27.120205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.036501731s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:21:27.12078Z","caller":"traceutil/trace.go:171","msg":"trace[1505088608] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:415; }","duration":"1.037110413s","start":"2026-03-31T18:21:26.083657Z","end":"2026-03-31T18:21:27.120767Z","steps":["trace[1505088608] 'agreement among raft nodes before linearized reading' (duration: 1.025809473s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:27.120852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:26.083637Z","time spent":"1.037202564s","remote":"127.0.0.1:37062","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-03-31T18:21:27.120606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:25.995028Z","time spent":"1.125556384s","remote":"127.0.0.1:37330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-03-31T18:21:43.370313Z","caller":"traceutil/trace.go:171","msg":"trace[847882164] linearizableReadLoop","detail":"{readStateIndex:501; appliedIndex:500; }","duration":"144.677885ms","start":"2026-03-31T18:21:43.225614Z","end":"2026-03-31T18:21:43.370292Z","steps":["trace[847882164] 'read index received' (duration: 144.487322ms)","trace[847882164] 'applied index is now lower than readState.Index' (duration: 189.683µs)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:43.370433Z","caller":"traceutil/trace.go:171","msg":"trace[47235797] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"159.84367ms","start":"2026-03-31T18:21:43.210552Z","end":"2026-03-31T18:21:43.370395Z","steps":["trace[47235797] 'process raft request' (duration: 159.599786ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:43.370537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.90807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-03-31T18:21:43.370574Z","caller":"traceutil/trace.go:171","msg":"trace[21013985] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:485; }","duration":"144.994391ms","start":"2026-03-31T18:21:43.225568Z","end":"2026-03-31T18:21:43.370563Z","steps":["trace[21013985] 'agreement among raft nodes before linearized reading' (duration: 144.91122ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:43.370622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.650797ms","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-03-31T18:21:43.370728Z","caller":"traceutil/trace.go:171","msg":"trace[1389240289] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:485; }","duration":"143.80414ms","start":"2026-03-31T18:21:43.226897Z","end":"2026-03-31T18:21:43.370701Z","steps":["trace[1389240289] 'agreement among raft nodes before linearized reading' (duration: 143.608367ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:43.370842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.962215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-03-31T18:21:43.370901Z","caller":"traceutil/trace.go:171","msg":"trace[2144971991] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:485; }","duration":"139.052468ms","start":"2026-03-31T18:21:43.23183Z","end":"2026-03-31T18:21:43.370882Z","steps":["trace[2144971991] 'agreement among raft nodes before linearized reading' (duration: 138.947846ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:43.804723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.27557ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:21:43.805241Z","caller":"traceutil/trace.go:171","msg":"trace[653074893] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"427.173388ms","start":"2026-03-31T18:21:43.378034Z","end":"2026-03-31T18:21:43.805207Z","steps":["trace[653074893] 'process raft request' (duration: 247.341378ms)","trace[653074893] 'compare' (duration: 179.173809ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:21:43.805419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:43.378011Z","time spent":"427.32118ms","remote":"127.0.0.1:37330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T18:21:43.80564Z","caller":"traceutil/trace.go:171","msg":"trace[306802953] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"418.223461ms","start":"2026-03-31T18:21:43.3874Z","end":"2026-03-31T18:21:43.805624Z","steps":["trace[306802953] 'process raft request' (duration: 417.668362ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:43.805807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:43.387376Z","time spent":"418.396544ms","remote":"127.0.0.1:37160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317292,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-31T18:21:43.805844Z","caller":"traceutil/trace.go:171","msg":"trace[1438571096] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"417.850275ms","start":"2026-03-31T18:21:43.387965Z","end":"2026-03-31T18:21:43.805815Z","steps":["trace[1438571096] 'process raft request' (duration: 417.700302ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:43.805942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:43.387957Z","time spent":"417.939816ms","remote":"127.0.0.1:37330","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-03-31T18:21:44.023943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.932549ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:21:44.024181Z","caller":"traceutil/trace.go:171","msg":"trace[124423414] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"192.186073ms","start":"2026-03-31T18:21:43.831973Z","end":"2026-03-31T18:21:44.024159Z","steps":["trace[124423414] 'process raft request' (duration: 192.080761ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:44.024265Z","caller":"traceutil/trace.go:171","msg":"trace[1306833072] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"192.790693ms","start":"2026-03-31T18:21:43.831421Z","end":"2026-03-31T18:21:44.024212Z","steps":["trace[1306833072] 'process raft request' (duration: 79.524198ms)","trace[1306833072] 'compare' (duration: 112.693315ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:21:44.532199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.475306ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:21:44.532333Z","caller":"traceutil/trace.go:171","msg":"trace[1689092197] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"439.682543ms","start":"2026-03-31T18:21:44.092638Z","end":"2026-03-31T18:21:44.53232Z","steps":["trace[1689092197] 'process raft request' (duration: 439.642772ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:44.532378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:44.092615Z","time spent":"439.744594ms","remote":"127.0.0.1:37408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2364,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-31T18:21:44.532506Z","caller":"traceutil/trace.go:171","msg":"trace[1122822570] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"440.185172ms","start":"2026-03-31T18:21:44.092254Z","end":"2026-03-31T18:21:44.532439Z","steps":["trace[1122822570] 'process raft request' (duration: 164.41748ms)","trace[1122822570] 'compare' (duration: 275.349674ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:21:44.532722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:44.092233Z","time spent":"440.421385ms","remote":"127.0.0.1:37408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1639,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-31T18:21:44.669987Z","caller":"traceutil/trace.go:171","msg":"trace[1910581486] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"133.22428ms","start":"2026-03-31T18:21:44.536735Z","end":"2026-03-31T18:21:44.669959Z","steps":["trace[1910581486] 'process raft request' (duration: 97.326458ms)","trace[1910581486] 'compare' (duration: 35.77463ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:44.673049Z","caller":"traceutil/trace.go:171","msg":"trace[1918296432] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"135.899156ms","start":"2026-03-31T18:21:44.537126Z","end":"2026-03-31T18:21:44.673025Z","steps":["trace[1918296432] 'process raft request' (duration: 135.782944ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:45.150028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.58631ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:21:45.150207Z","caller":"traceutil/trace.go:171","msg":"trace[1125576109] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"413.008702ms","start":"2026-03-31T18:21:44.737134Z","end":"2026-03-31T18:21:45.150143Z","steps":["trace[1125576109] 'process raft request' (duration: 249.232499ms)","trace[1125576109] 'compare' (duration: 163.415907ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:21:45.150331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:44.737112Z","time spent":"413.180075ms","remote":"127.0.0.1:37534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-31T18:21:45.200958Z","caller":"traceutil/trace.go:171","msg":"trace[1854346936] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"359.958958ms","start":"2026-03-31T18:21:44.840967Z","end":"2026-03-31T18:21:45.200926Z","steps":["trace[1854346936] 'process raft request' (duration: 359.658643ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:45.201205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:44.840949Z","time spent":"360.141001ms","remote":"127.0.0.1:37524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4177,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-31T18:21:45.201542Z","caller":"traceutil/trace.go:171","msg":"trace[179646161] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:517; }","duration":"127.463896ms","start":"2026-03-31T18:21:45.074054Z","end":"2026-03-31T18:21:45.201518Z","steps":["trace[179646161] 'read index received' (duration: 126.574361ms)","trace[179646161] 'applied index is now lower than readState.Index' (duration: 888.645µs)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:45.201627Z","caller":"traceutil/trace.go:171","msg":"trace[1000581811] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"286.055967ms","start":"2026-03-31T18:21:44.915539Z","end":"2026-03-31T18:21:45.201595Z","steps":["trace[1000581811] 'process raft request' (duration: 285.273423ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:45.201714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.632939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:21:45.20175Z","caller":"traceutil/trace.go:171","msg":"trace[619980879] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:503; }","duration":"127.734601ms","start":"2026-03-31T18:21:45.074003Z","end":"2026-03-31T18:21:45.201738Z","steps":["trace[619980879] 'agreement among raft nodes before linearized reading' (duration: 127.644399ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:45.366551Z","caller":"traceutil/trace.go:171","msg":"trace[1008043161] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"160.720958ms","start":"2026-03-31T18:21:45.205796Z","end":"2026-03-31T18:21:45.366517Z","steps":["trace[1008043161] 'process raft request' (duration: 65.04795ms)","trace[1008043161] 'compare' (duration: 95.397063ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:45.366616Z","caller":"traceutil/trace.go:171","msg":"trace[1187086046] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"156.219091ms","start":"2026-03-31T18:21:45.21037Z","end":"2026-03-31T18:21:45.366589Z","steps":["trace[1187086046] 'process raft request' (duration: 156.072049ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:45.366725Z","caller":"traceutil/trace.go:171","msg":"trace[494743599] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"160.146278ms","start":"2026-03-31T18:21:45.206557Z","end":"2026-03-31T18:21:45.366703Z","steps":["trace[494743599] 'process raft request' (duration: 159.844113ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:45.366792Z","caller":"traceutil/trace.go:171","msg":"trace[1260410897] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"156.338984ms","start":"2026-03-31T18:21:45.210379Z","end":"2026-03-31T18:21:45.366718Z","steps":["trace[1260410897] 'process raft request' (duration: 156.11709ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:45.615745Z","caller":"traceutil/trace.go:171","msg":"trace[1167823825] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"243.075887ms","start":"2026-03-31T18:21:45.372641Z","end":"2026-03-31T18:21:45.615717Z","steps":["trace[1167823825] 'process raft request' (duration: 242.943664ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:45.6159Z","caller":"traceutil/trace.go:171","msg":"trace[1874567587] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"243.313301ms","start":"2026-03-31T18:21:45.372556Z","end":"2026-03-31T18:21:45.615869Z","steps":["trace[1874567587] 'process raft request' (duration: 159.521318ms)","trace[1874567587] 'compare' (duration: 83.389076ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:45.616518Z","caller":"traceutil/trace.go:171","msg":"trace[993030562] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"243.82455ms","start":"2026-03-31T18:21:45.372669Z","end":"2026-03-31T18:21:45.616493Z","steps":["trace[993030562] 'process raft request' (duration: 242.998016ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:45.616579Z","caller":"traceutil/trace.go:171","msg":"trace[608846259] linearizableReadLoop","detail":"{readStateIndex:528; appliedIndex:523; }","duration":"243.307801ms","start":"2026-03-31T18:21:45.373245Z","end":"2026-03-31T18:21:45.616552Z","steps":["trace[608846259] 'read index received' (duration: 8.082149ms)","trace[608846259] 'applied index is now lower than readState.Index' (duration: 235.224732ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:45.616653Z","caller":"traceutil/trace.go:171","msg":"trace[1685172962] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"243.691307ms","start":"2026-03-31T18:21:45.372937Z","end":"2026-03-31T18:21:45.616628Z","steps":["trace[1685172962] 'process raft request' (duration: 243.433223ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:45.616803Z","caller":"traceutil/trace.go:171","msg":"trace[979510593] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"239.980804ms","start":"2026-03-31T18:21:45.376808Z","end":"2026-03-31T18:21:45.616789Z","steps":["trace[979510593] 'process raft request' (duration: 239.684969ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:45.616832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.570625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/cilium-operator\" ","response":"range_response_count:1 size:4335"} {"level":"info","ts":"2026-03-31T18:21:45.61687Z","caller":"traceutil/trace.go:171","msg":"trace[1021728167] range","detail":"{range_begin:/registry/deployments/kube-system/cilium-operator; range_end:; response_count:1; response_revision:513; }","duration":"243.619066ms","start":"2026-03-31T18:21:45.37324Z","end":"2026-03-31T18:21:45.616859Z","steps":["trace[1021728167] 'agreement among raft nodes before linearized reading' (duration: 243.535385ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:45.61695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.352367ms","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-03-31T18:21:45.617148Z","caller":"traceutil/trace.go:171","msg":"trace[1237588792] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:513; }","duration":"241.578571ms","start":"2026-03-31T18:21:45.375559Z","end":"2026-03-31T18:21:45.617138Z","steps":["trace[1237588792] 'agreement among raft nodes before linearized reading' (duration: 241.337477ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:45.617297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.159639ms","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-03-31T18:21:45.617323Z","caller":"traceutil/trace.go:171","msg":"trace[1436480505] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:513; }","duration":"196.186979ms","start":"2026-03-31T18:21:45.421128Z","end":"2026-03-31T18:21:45.617315Z","steps":["trace[1436480505] 'agreement among raft nodes before linearized reading' (duration: 196.138978ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:45.617622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.357475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329960"} {"level":"info","ts":"2026-03-31T18:21:45.6177Z","caller":"traceutil/trace.go:171","msg":"trace[544860548] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:513; }","duration":"141.489897ms","start":"2026-03-31T18:21:45.476189Z","end":"2026-03-31T18:21:45.617679Z","steps":["trace[544860548] 'agreement among raft nodes before linearized reading' (duration: 140.950268ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:45.75377Z","caller":"traceutil/trace.go:171","msg":"trace[190887489] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"129.322018ms","start":"2026-03-31T18:21:45.624348Z","end":"2026-03-31T18:21:45.75367Z","steps":["trace[190887489] 'process raft request' (duration: 93.948789ms)","trace[190887489] 'compare' (duration: 35.035604ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:45.753829Z","caller":"traceutil/trace.go:171","msg":"trace[499093663] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"128.926451ms","start":"2026-03-31T18:21:45.62487Z","end":"2026-03-31T18:21:45.753796Z","steps":["trace[499093663] 'process raft request' (duration: 128.633986ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:45.754344Z","caller":"traceutil/trace.go:171","msg":"trace[2104632216] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"129.055694ms","start":"2026-03-31T18:21:45.625274Z","end":"2026-03-31T18:21:45.75433Z","steps":["trace[2104632216] 'process raft request' (duration: 128.294961ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:45.754593Z","caller":"traceutil/trace.go:171","msg":"trace[1470075842] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"127.68988ms","start":"2026-03-31T18:21:45.626868Z","end":"2026-03-31T18:21:45.754558Z","steps":["trace[1470075842] 'process raft request' (duration: 127.068549ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:47.05497Z","caller":"traceutil/trace.go:171","msg":"trace[769403803] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"104.392442ms","start":"2026-03-31T18:21:46.950547Z","end":"2026-03-31T18:21:47.05494Z","steps":["trace[769403803] 'process raft request' (duration: 103.976155ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:47.055243Z","caller":"traceutil/trace.go:171","msg":"trace[1976471074] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"106.372656ms","start":"2026-03-31T18:21:46.948856Z","end":"2026-03-31T18:21:47.055229Z","steps":["trace[1976471074] 'process raft request' (duration: 105.627393ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:47.055402Z","caller":"traceutil/trace.go:171","msg":"trace[453613308] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"114.915541ms","start":"2026-03-31T18:21:46.940473Z","end":"2026-03-31T18:21:47.055389Z","steps":["trace[453613308] 'process raft request' (duration: 113.974885ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:47.055605Z","caller":"traceutil/trace.go:171","msg":"trace[1176117732] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"117.036248ms","start":"2026-03-31T18:21:46.938558Z","end":"2026-03-31T18:21:47.055594Z","steps":["trace[1176117732] 'process raft request' (duration: 115.735236ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:47.055882Z","caller":"traceutil/trace.go:171","msg":"trace[1313121590] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"103.367184ms","start":"2026-03-31T18:21:46.952504Z","end":"2026-03-31T18:21:47.055871Z","steps":["trace[1313121590] 'process raft request' (duration: 102.083012ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:47.056178Z","caller":"traceutil/trace.go:171","msg":"trace[1998029424] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"103.7001ms","start":"2026-03-31T18:21:46.95246Z","end":"2026-03-31T18:21:47.05616Z","steps":["trace[1998029424] 'process raft request' (duration: 102.179714ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:47.055167Z","caller":"traceutil/trace.go:171","msg":"trace[2085494238] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"116.534059ms","start":"2026-03-31T18:21:46.938615Z","end":"2026-03-31T18:21:47.055149Z","steps":["trace[2085494238] 'process raft request' (duration: 115.790067ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:47.059626Z","caller":"traceutil/trace.go:171","msg":"trace[1534457912] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"102.608061ms","start":"2026-03-31T18:21:46.952471Z","end":"2026-03-31T18:21:47.055079Z","steps":["trace[1534457912] 'process raft request' (duration: 102.083792ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:47.113623Z","caller":"traceutil/trace.go:171","msg":"trace[744969873] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"107.097291ms","start":"2026-03-31T18:21:47.006507Z","end":"2026-03-31T18:21:47.113605Z","steps":["trace[744969873] 'process raft request' (duration: 106.969579ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:47.306868Z","caller":"traceutil/trace.go:171","msg":"trace[402098415] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"241.861095ms","start":"2026-03-31T18:21:47.064732Z","end":"2026-03-31T18:21:47.306593Z","steps":["trace[402098415] 'process raft request' (duration: 200.011542ms)","trace[402098415] 'compare' (duration: 40.899366ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:47.307492Z","caller":"traceutil/trace.go:171","msg":"trace[1171770113] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"237.210355ms","start":"2026-03-31T18:21:47.070237Z","end":"2026-03-31T18:21:47.307447Z","steps":["trace[1171770113] 'process raft request' (duration: 235.589337ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:47.307603Z","caller":"traceutil/trace.go:171","msg":"trace[82905055] transaction","detail":"{read_only:false; number_of_response:1; response_revision:544; }","duration":"237.061072ms","start":"2026-03-31T18:21:47.070509Z","end":"2026-03-31T18:21:47.307571Z","steps":["trace[82905055] 'process raft request' (duration: 235.955503ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:47.307693Z","caller":"traceutil/trace.go:171","msg":"trace[1376196274] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"241.02616ms","start":"2026-03-31T18:21:47.066281Z","end":"2026-03-31T18:21:47.307308Z","steps":["trace[1376196274] 'process raft request' (duration: 239.518824ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:47.308069Z","caller":"traceutil/trace.go:171","msg":"trace[732812726] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"241.885614ms","start":"2026-03-31T18:21:47.064991Z","end":"2026-03-31T18:21:47.306876Z","steps":["trace[732812726] 'process raft request' (duration: 240.795066ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:47.30845Z","caller":"traceutil/trace.go:171","msg":"trace[1564551272] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"237.993799ms","start":"2026-03-31T18:21:47.070439Z","end":"2026-03-31T18:21:47.308433Z","steps":["trace[1564551272] 'process raft request' (duration: 235.808182ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:47.308466Z","caller":"traceutil/trace.go:171","msg":"trace[1823076481] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"241.04534ms","start":"2026-03-31T18:21:47.064827Z","end":"2026-03-31T18:21:47.305873Z","steps":["trace[1823076481] 'process raft request' (duration: 240.934608ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:47.309193Z","caller":"traceutil/trace.go:171","msg":"trace[1867755191] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"237.183014ms","start":"2026-03-31T18:21:47.071982Z","end":"2026-03-31T18:21:47.309165Z","steps":["trace[1867755191] 'process raft request' (duration: 234.764923ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:47.312724Z","caller":"traceutil/trace.go:171","msg":"trace[1529508682] linearizableReadLoop","detail":"{readStateIndex:562; appliedIndex:555; }","duration":"240.864908ms","start":"2026-03-31T18:21:47.071827Z","end":"2026-03-31T18:21:47.312692Z","steps":["trace[1529508682] 'read index received' (duration: 42.275379ms)","trace[1529508682] 'applied index is now lower than readState.Index' (duration: 198.588769ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:21:47.312807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.966459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:21:47.312832Z","caller":"traceutil/trace.go:171","msg":"trace[1597317537] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:549; }","duration":"241.024661ms","start":"2026-03-31T18:21:47.0718Z","end":"2026-03-31T18:21:47.312825Z","steps":["trace[1597317537] 'agreement among raft nodes before linearized reading' (duration: 240.9584ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:47.312954Z","caller":"traceutil/trace.go:171","msg":"trace[522347598] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"236.147238ms","start":"2026-03-31T18:21:47.0768Z","end":"2026-03-31T18:21:47.312947Z","steps":["trace[522347598] 'process raft request' (duration: 233.683866ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:47.313039Z","caller":"traceutil/trace.go:171","msg":"trace[1145700077] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"235.14411ms","start":"2026-03-31T18:21:47.077889Z","end":"2026-03-31T18:21:47.313033Z","steps":["trace[1145700077] 'process raft request' (duration: 234.585101ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:47.313133Z","caller":"traceutil/trace.go:171","msg":"trace[1256133329] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"231.908826ms","start":"2026-03-31T18:21:47.081197Z","end":"2026-03-31T18:21:47.313106Z","steps":["trace[1256133329] 'process raft request' (duration: 231.376697ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:47.313223Z","caller":"traceutil/trace.go:171","msg":"trace[365362497] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"201.881624ms","start":"2026-03-31T18:21:47.111335Z","end":"2026-03-31T18:21:47.313217Z","steps":["trace[365362497] 'process raft request' (duration: 201.308215ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:48.792003Z","caller":"traceutil/trace.go:171","msg":"trace[1828682605] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"512.043163ms","start":"2026-03-31T18:21:48.279935Z","end":"2026-03-31T18:21:48.791978Z","steps":["trace[1828682605] 'process raft request' (duration: 511.25341ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:48.792134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:48.279903Z","time spent":"512.167196ms","remote":"127.0.0.1:37118","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T18:21:48.822381Z","caller":"traceutil/trace.go:171","msg":"trace[347195918] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"483.228357ms","start":"2026-03-31T18:21:48.339133Z","end":"2026-03-31T18:21:48.822362Z","steps":["trace[347195918] 'process raft request' (duration: 483.102625ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:48.822501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:48.339105Z","time spent":"483.344439ms","remote":"127.0.0.1:37118","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":207462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-31T18:21:53.853863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.908321ms","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-03-31T18:21:53.853937Z","caller":"traceutil/trace.go:171","msg":"trace[1717200820] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:630; }","duration":"113.017833ms","start":"2026-03-31T18:21:53.740901Z","end":"2026-03-31T18:21:53.853918Z","steps":["trace[1717200820] 'range keys from in-memory index tree' (duration: 112.770588ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:56.1702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.7694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-03-31T18:21:56.170284Z","caller":"traceutil/trace.go:171","msg":"trace[549535420] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:646; }","duration":"197.913601ms","start":"2026-03-31T18:21:55.972353Z","end":"2026-03-31T18:21:56.170267Z","steps":["trace[549535420] 'range keys from in-memory index tree' (duration: 197.575065ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:56.170327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.715539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-03-31T18:21:56.170347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.386834ms","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-03-31T18:21:56.170404Z","caller":"traceutil/trace.go:171","msg":"trace[1677801877] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:646; }","duration":"197.82736ms","start":"2026-03-31T18:21:55.972556Z","end":"2026-03-31T18:21:56.170383Z","steps":["trace[1677801877] 'range keys from in-memory index tree' (duration: 197.549736ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:56.170412Z","caller":"traceutil/trace.go:171","msg":"trace[1132489783] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:646; }","duration":"299.486456ms","start":"2026-03-31T18:21:55.870907Z","end":"2026-03-31T18:21:56.170394Z","steps":["trace[1132489783] 'range keys from in-memory index tree' (duration: 299.208572ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:56.170322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.466069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-nbp2n\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-03-31T18:21:56.170521Z","caller":"traceutil/trace.go:171","msg":"trace[454656312] range","detail":"{range_begin:/registry/pods/kube-system/cilium-nbp2n; range_end:; response_count:1; response_revision:646; }","duration":"141.718163ms","start":"2026-03-31T18:21:56.028782Z","end":"2026-03-31T18:21:56.1705Z","steps":["trace[454656312] 'range keys from in-memory index tree' (duration: 141.223615ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:56.170838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.866022ms","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-03-31T18:21:56.170879Z","caller":"traceutil/trace.go:171","msg":"trace[1808299790] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:646; }","duration":"186.935254ms","start":"2026-03-31T18:21:55.983935Z","end":"2026-03-31T18:21:56.17087Z","steps":["trace[1808299790] 'range keys from in-memory index tree' (duration: 186.518876ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:56.392131Z","caller":"traceutil/trace.go:171","msg":"trace[1375965603] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"217.776427ms","start":"2026-03-31T18:21:56.174325Z","end":"2026-03-31T18:21:56.392102Z","steps":["trace[1375965603] 'process raft request' (duration: 217.697976ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:56.392172Z","caller":"traceutil/trace.go:171","msg":"trace[1640875516] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"217.896ms","start":"2026-03-31T18:21:56.174237Z","end":"2026-03-31T18:21:56.392133Z","steps":["trace[1640875516] 'process raft request' (duration: 217.657516ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:56.39241Z","caller":"traceutil/trace.go:171","msg":"trace[2031792031] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"217.968741ms","start":"2026-03-31T18:21:56.174425Z","end":"2026-03-31T18:21:56.392394Z","steps":["trace[2031792031] 'process raft request' (duration: 217.638245ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:56.392527Z","caller":"traceutil/trace.go:171","msg":"trace[1083319060] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"208.987396ms","start":"2026-03-31T18:21:56.183528Z","end":"2026-03-31T18:21:56.392516Z","steps":["trace[1083319060] 'process raft request' (duration: 208.785773ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:57.187325Z","caller":"traceutil/trace.go:171","msg":"trace[917398738] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:673; }","duration":"114.009185ms","start":"2026-03-31T18:21:57.073291Z","end":"2026-03-31T18:21:57.1873Z","steps":["trace[917398738] 'read index received' (duration: 76.17344ms)","trace[917398738] 'applied index is now lower than readState.Index' (duration: 37.834545ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:21:57.187443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.126637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:21:57.187474Z","caller":"traceutil/trace.go:171","msg":"trace[736261908] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:651; }","duration":"114.212099ms","start":"2026-03-31T18:21:57.073251Z","end":"2026-03-31T18:21:57.187463Z","steps":["trace[736261908] 'agreement among raft nodes before linearized reading' (duration: 114.136678ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:58.733103Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":184257554996170058,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-31T18:21:58.836062Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.473173013s","expected-duration":"1s"} {"level":"info","ts":"2026-03-31T18:21:58.83644Z","caller":"traceutil/trace.go:171","msg":"trace[1107857572] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:674; }","duration":"603.69741ms","start":"2026-03-31T18:21:58.232726Z","end":"2026-03-31T18:21:58.836423Z","steps":["trace[1107857572] 'read index received' (duration: 603.449496ms)","trace[1107857572] 'applied index is now lower than readState.Index' (duration: 247.334µs)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:58.836685Z","caller":"traceutil/trace.go:171","msg":"trace[319636879] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"1.473882734s","start":"2026-03-31T18:21:57.362772Z","end":"2026-03-31T18:21:58.836654Z","steps":["trace[319636879] 'process raft request' (duration: 1.473485687s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:58.836837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.823008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-03-31T18:21:58.836852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:57.362751Z","time spent":"1.474016306s","remote":"127.0.0.1:37330","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-03-31T18:21:58.836883Z","caller":"traceutil/trace.go:171","msg":"trace[167022264] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:652; }","duration":"440.93659ms","start":"2026-03-31T18:21:58.395932Z","end":"2026-03-31T18:21:58.836869Z","steps":["trace[167022264] 'agreement among raft nodes before linearized reading' (duration: 440.821318ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:58.837025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:58.395912Z","time spent":"441.100672ms","remote":"127.0.0.1:37330","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":"warn","ts":"2026-03-31T18:21:58.83672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.985664ms","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-03-31T18:21:58.837171Z","caller":"traceutil/trace.go:171","msg":"trace[2032419822] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:652; }","duration":"604.460362ms","start":"2026-03-31T18:21:58.232672Z","end":"2026-03-31T18:21:58.837133Z","steps":["trace[2032419822] 'agreement among raft nodes before linearized reading' (duration: 603.915193ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:58.837278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:58.232652Z","time spent":"604.591294ms","remote":"127.0.0.1:37330","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-03-31T18:21:58.837439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.518168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-03-31T18:21:58.837418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.466788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-03-31T18:21:58.837476Z","caller":"traceutil/trace.go:171","msg":"trace[1209453584] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:652; }","duration":"441.60432ms","start":"2026-03-31T18:21:58.395861Z","end":"2026-03-31T18:21:58.837466Z","steps":["trace[1209453584] 'agreement among raft nodes before linearized reading' (duration: 440.900419ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:58.837691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:58.395844Z","time spent":"441.835784ms","remote":"127.0.0.1:37330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-03-31T18:21:58.837771Z","caller":"traceutil/trace.go:171","msg":"trace[717507424] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:652; }","duration":"441.649691ms","start":"2026-03-31T18:21:58.395929Z","end":"2026-03-31T18:21:58.837579Z","steps":["trace[717507424] 'agreement among raft nodes before linearized reading' (duration: 441.015751ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:58.83791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:58.39587Z","time spent":"442.021447ms","remote":"127.0.0.1:37330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-03-31T18:22:09.097019Z","caller":"traceutil/trace.go:171","msg":"trace[174239626] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"279.627212ms","start":"2026-03-31T18:22:08.817369Z","end":"2026-03-31T18:22:09.096996Z","steps":["trace[174239626] 'process raft request' (duration: 279.46594ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:09.440909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.561665ms","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-03-31T18:22:09.441028Z","caller":"traceutil/trace.go:171","msg":"trace[253500581] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:770; }","duration":"175.706257ms","start":"2026-03-31T18:22:09.265304Z","end":"2026-03-31T18:22:09.441011Z","steps":["trace[253500581] 'range keys from in-memory index tree' (duration: 175.542555ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:09.451292Z","caller":"traceutil/trace.go:171","msg":"trace[309836884] linearizableReadLoop","detail":"{readStateIndex:797; appliedIndex:795; }","duration":"499.317748ms","start":"2026-03-31T18:22:08.951948Z","end":"2026-03-31T18:22:09.451266Z","steps":["trace[309836884] 'read index received' (duration: 144.95775ms)","trace[309836884] 'applied index is now lower than readState.Index' (duration: 354.358538ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:22:09.451705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.743235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-03-31T18:22:09.451755Z","caller":"traceutil/trace.go:171","msg":"trace[97252257] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:771; }","duration":"499.851926ms","start":"2026-03-31T18:22:08.951889Z","end":"2026-03-31T18:22:09.451741Z","steps":["trace[97252257] 'agreement among raft nodes before linearized reading' (duration: 499.527741ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:09.451805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:08.951864Z","time spent":"499.931748ms","remote":"127.0.0.1:37330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-03-31T18:22:09.451713Z","caller":"traceutil/trace.go:171","msg":"trace[1537792291] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"588.779408ms","start":"2026-03-31T18:22:08.862641Z","end":"2026-03-31T18:22:09.45142Z","steps":["trace[1537792291] 'process raft request' (duration: 588.475834ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:09.451974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.577416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-03-31T18:22:09.452132Z","caller":"traceutil/trace.go:171","msg":"trace[639127228] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:771; }","duration":"486.80078ms","start":"2026-03-31T18:22:08.965303Z","end":"2026-03-31T18:22:09.452104Z","steps":["trace[639127228] 'agreement among raft nodes before linearized reading' (duration: 486.383373ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:09.452203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:08.96528Z","time spent":"486.909891ms","remote":"127.0.0.1:37330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-31T18:22:09.452352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.581959ms","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-03-31T18:22:09.452397Z","caller":"traceutil/trace.go:171","msg":"trace[112100964] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:771; }","duration":"463.64745ms","start":"2026-03-31T18:22:08.988738Z","end":"2026-03-31T18:22:09.452385Z","steps":["trace[112100964] 'agreement among raft nodes before linearized reading' (duration: 463.535178ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:09.452436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:08.988727Z","time spent":"463.70133ms","remote":"127.0.0.1:37330","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-03-31T18:22:09.452358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:08.862623Z","time spent":"589.390377ms","remote":"127.0.0.1:37330","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-03-31T18:22:09.45256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.881395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-31T18:22:09.452597Z","caller":"traceutil/trace.go:171","msg":"trace[1712208882] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:771; }","duration":"206.942216ms","start":"2026-03-31T18:22:09.245644Z","end":"2026-03-31T18:22:09.452586Z","steps":["trace[1712208882] 'agreement among raft nodes before linearized reading' (duration: 206.876115ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:09.452742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.29533ms","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-03-31T18:22:09.452789Z","caller":"traceutil/trace.go:171","msg":"trace[1530725102] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:771; }","duration":"472.371402ms","start":"2026-03-31T18:22:08.980406Z","end":"2026-03-31T18:22:09.452777Z","steps":["trace[1530725102] 'agreement among raft nodes before linearized reading' (duration: 472.25204ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:09.452829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:08.980388Z","time spent":"472.433252ms","remote":"127.0.0.1:37330","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":"warn","ts":"2026-03-31T18:22:16.960502Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":184257554996170384,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-31T18:22:17.46148Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":184257554996170384,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-31T18:22:17.475227Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.312841792s","expected-duration":"1s"} {"level":"info","ts":"2026-03-31T18:22:17.475831Z","caller":"traceutil/trace.go:171","msg":"trace[1832584076] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"1.313550413s","start":"2026-03-31T18:22:16.162249Z","end":"2026-03-31T18:22:17.4758Z","steps":["trace[1832584076] 'process raft request' (duration: 1.313314179s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.476173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:16.16222Z","time spent":"1.313836617s","remote":"127.0.0.1:37316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T18:22:17.518267Z","caller":"traceutil/trace.go:171","msg":"trace[1029102952] linearizableReadLoop","detail":"{readStateIndex:844; appliedIndex:842; }","duration":"1.061663766s","start":"2026-03-31T18:22:16.456571Z","end":"2026-03-31T18:22:17.518235Z","steps":["trace[1029102952] 'read index received' (duration: 1.01895124s)","trace[1029102952] 'applied index is now lower than readState.Index' (duration: 42.710996ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:22:17.518484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.042956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T18:22:17.518486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.061888079s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-31T18:22:17.518525Z","caller":"traceutil/trace.go:171","msg":"trace[1426094545] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:815; }","duration":"748.154728ms","start":"2026-03-31T18:22:16.77036Z","end":"2026-03-31T18:22:17.518515Z","steps":["trace[1426094545] 'agreement among raft nodes before linearized reading' (duration: 748.051197ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:17.518558Z","caller":"traceutil/trace.go:171","msg":"trace[1665465864] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:815; }","duration":"1.062003901s","start":"2026-03-31T18:22:16.456535Z","end":"2026-03-31T18:22:17.518539Z","steps":["trace[1665465864] 'agreement among raft nodes before linearized reading' (duration: 1.061808669s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.518576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:16.770331Z","time spent":"748.230829ms","remote":"127.0.0.1:41362","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/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-03-31T18:22:17.518602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:16.456505Z","time spent":"1.062087702s","remote":"127.0.0.1:37556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":95,"response size":29,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-03-31T18:22:17.518889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.790307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T18:22:17.518899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.0611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:17.51893Z","caller":"traceutil/trace.go:171","msg":"trace[1234809387] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:815; }","duration":"566.872859ms","start":"2026-03-31T18:22:16.952045Z","end":"2026-03-31T18:22:17.518918Z","steps":["trace[1234809387] 'agreement among raft nodes before linearized reading' (duration: 566.815758ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.518898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.610069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T18:22:17.519004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.649007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:17.519038Z","caller":"traceutil/trace.go:171","msg":"trace[1676368656] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:815; }","duration":"593.706378ms","start":"2026-03-31T18:22:16.925324Z","end":"2026-03-31T18:22:17.51903Z","steps":["trace[1676368656] 'agreement among raft nodes before linearized reading' (duration: 593.659727ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.518889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.086109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T18:22:17.519128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.496216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T18:22:17.519154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.540515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:17.519168Z","caller":"traceutil/trace.go:171","msg":"trace[1872349884] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:815; }","duration":"367.536106ms","start":"2026-03-31T18:22:17.151617Z","end":"2026-03-31T18:22:17.519153Z","steps":["trace[1872349884] 'agreement among raft nodes before linearized reading' (duration: 367.491996ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:17.51918Z","caller":"traceutil/trace.go:171","msg":"trace[1962220517] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:815; }","duration":"624.593166ms","start":"2026-03-31T18:22:16.89458Z","end":"2026-03-31T18:22:17.519173Z","steps":["trace[1962220517] 'agreement among raft nodes before linearized reading' (duration: 624.556985ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:17.519161Z","caller":"traceutil/trace.go:171","msg":"trace[817608222] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:815; }","duration":"502.404764ms","start":"2026-03-31T18:22:17.016742Z","end":"2026-03-31T18:22:17.519147Z","steps":["trace[817608222] 'agreement among raft nodes before linearized reading' (duration: 502.073219ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.519135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.780029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T18:22:17.519254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.084373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T18:22:17.519232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.351267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T18:22:17.519322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.256026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:17.519352Z","caller":"traceutil/trace.go:171","msg":"trace[50496192] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:815; }","duration":"625.309926ms","start":"2026-03-31T18:22:16.894034Z","end":"2026-03-31T18:22:17.519344Z","steps":["trace[50496192] 'agreement among raft nodes before linearized reading' (duration: 625.271816ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.519349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.858687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T18:22:17.519379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:16.894018Z","time spent":"625.353856ms","remote":"127.0.0.1:41400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-03-31T18:22:17.519408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.893678ms","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-03-31T18:22:17.519356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:17.016733Z","time spent":"502.515796ms","remote":"127.0.0.1:41436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"info","ts":"2026-03-31T18:22:17.519441Z","caller":"traceutil/trace.go:171","msg":"trace[1806950975] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:815; }","duration":"382.959429ms","start":"2026-03-31T18:22:17.136473Z","end":"2026-03-31T18:22:17.519433Z","steps":["trace[1806950975] 'agreement among raft nodes before linearized reading' (duration: 382.838358ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:17.519386Z","caller":"traceutil/trace.go:171","msg":"trace[1638797370] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:815; }","duration":"503.49175ms","start":"2026-03-31T18:22:17.015834Z","end":"2026-03-31T18:22:17.519326Z","steps":["trace[1638797370] 'agreement among raft nodes before linearized reading' (duration: 503.353908ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.519493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.502348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T18:22:17.519531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.261867ms","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-03-31T18:22:17.519552Z","caller":"traceutil/trace.go:171","msg":"trace[285531355] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:815; }","duration":"275.63539ms","start":"2026-03-31T18:22:17.243908Z","end":"2026-03-31T18:22:17.519544Z","steps":["trace[285531355] 'agreement among raft nodes before linearized reading' (duration: 275.558649ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.519565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.922919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T18:22:17.519639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"749.088331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:17.519652Z","caller":"traceutil/trace.go:171","msg":"trace[61740760] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:815; }","duration":"446.05304ms","start":"2026-03-31T18:22:17.073583Z","end":"2026-03-31T18:22:17.519636Z","steps":["trace[61740760] 'agreement among raft nodes before linearized reading' (duration: 445.168348ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.519649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.564182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:17.519677Z","caller":"traceutil/trace.go:171","msg":"trace[1635914266] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:815; }","duration":"749.182423ms","start":"2026-03-31T18:22:16.770485Z","end":"2026-03-31T18:22:17.519668Z","steps":["trace[1635914266] 'agreement among raft nodes before linearized reading' (duration: 749.133512ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:17.51969Z","caller":"traceutil/trace.go:171","msg":"trace[331892883] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:815; }","duration":"242.619603ms","start":"2026-03-31T18:22:17.27706Z","end":"2026-03-31T18:22:17.519679Z","steps":["trace[331892883] 'agreement among raft nodes before linearized reading' (duration: 242.562502ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.519591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.834918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T18:22:17.519714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.429989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:17.519726Z","caller":"traceutil/trace.go:171","msg":"trace[2060621964] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:815; }","duration":"749.024001ms","start":"2026-03-31T18:22:16.770695Z","end":"2026-03-31T18:22:17.519719Z","steps":["trace[2060621964] 'agreement among raft nodes before linearized reading' (duration: 748.865478ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:17.519748Z","caller":"traceutil/trace.go:171","msg":"trace[1631428874] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:815; }","duration":"714.4882ms","start":"2026-03-31T18:22:16.805252Z","end":"2026-03-31T18:22:17.51974Z","steps":["trace[1631428874] 'agreement among raft nodes before linearized reading' (duration: 714.442899ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.519005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.342514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T18:22:17.519783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:16.805236Z","time spent":"714.53737ms","remote":"127.0.0.1:41372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-03-31T18:22:17.519767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.579577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T18:22:17.51986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.220906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:17.519928Z","caller":"traceutil/trace.go:171","msg":"trace[191543504] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:815; }","duration":"395.312567ms","start":"2026-03-31T18:22:17.124604Z","end":"2026-03-31T18:22:17.519917Z","steps":["trace[191543504] 'agreement among raft nodes before linearized reading' (duration: 395.236766ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.519694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:17.073577Z","time spent":"446.107671ms","remote":"127.0.0.1:41454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 "} {"level":"warn","ts":"2026-03-31T18:22:17.519678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.91363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:17.519563Z","caller":"traceutil/trace.go:171","msg":"trace[1268336597] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:815; }","duration":"714.330017ms","start":"2026-03-31T18:22:16.805225Z","end":"2026-03-31T18:22:17.519555Z","steps":["trace[1268336597] 'agreement among raft nodes before linearized reading' (duration: 714.286147ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:17.520005Z","caller":"traceutil/trace.go:171","msg":"trace[1814146830] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:815; }","duration":"678.264624ms","start":"2026-03-31T18:22:16.841731Z","end":"2026-03-31T18:22:17.519996Z","steps":["trace[1814146830] 'agreement among raft nodes before linearized reading' (duration: 677.92849ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.520015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.564978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T18:22:17.520025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.604193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T18:22:17.520091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.527702ms","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-03-31T18:22:17.520096Z","caller":"traceutil/trace.go:171","msg":"trace[1517775631] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:815; }","duration":"276.746756ms","start":"2026-03-31T18:22:17.243338Z","end":"2026-03-31T18:22:17.520085Z","steps":["trace[1517775631] 'agreement among raft nodes before linearized reading' (duration: 276.569003ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:17.519862Z","caller":"traceutil/trace.go:171","msg":"trace[363594103] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:815; }","duration":"551.735819ms","start":"2026-03-31T18:22:16.968117Z","end":"2026-03-31T18:22:17.519853Z","steps":["trace[363594103] 'agreement among raft nodes before linearized reading' (duration: 551.574197ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.520165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.793256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T18:22:17.52018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:16.968089Z","time spent":"552.073764ms","remote":"127.0.0.1:41424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"info","ts":"2026-03-31T18:22:17.520205Z","caller":"traceutil/trace.go:171","msg":"trace[2126880824] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:815; }","duration":"420.860236ms","start":"2026-03-31T18:22:17.099335Z","end":"2026-03-31T18:22:17.520196Z","steps":["trace[2126880824] 'agreement among raft nodes before linearized reading' (duration: 420.809186ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.520129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.048565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T18:22:17.520249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:17.099319Z","time spent":"420.921037ms","remote":"127.0.0.1:41458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"warn","ts":"2026-03-31T18:22:17.520256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.519608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T18:22:17.52026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.022508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:17.52029Z","caller":"traceutil/trace.go:171","msg":"trace[1208639365] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:815; }","duration":"567.582369ms","start":"2026-03-31T18:22:16.952699Z","end":"2026-03-31T18:22:17.520281Z","steps":["trace[1208639365] 'agreement among raft nodes before linearized reading' (duration: 567.531228ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.520347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:16.952672Z","time spent":"567.66667ms","remote":"127.0.0.1:41414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"warn","ts":"2026-03-31T18:22:17.519473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:17.136431Z","time spent":"383.03667ms","remote":"127.0.0.1:37330","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-03-31T18:22:17.520426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.855014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:17.520465Z","caller":"traceutil/trace.go:171","msg":"trace[153322303] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:815; }","duration":"442.904265ms","start":"2026-03-31T18:22:17.077551Z","end":"2026-03-31T18:22:17.520456Z","steps":["trace[153322303] 'agreement among raft nodes before linearized reading' (duration: 442.847304ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.520497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:17.077545Z","time spent":"442.946216ms","remote":"127.0.0.1:37062","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-03-31T18:22:17.520557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.668673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:17.519423Z","caller":"traceutil/trace.go:171","msg":"trace[1668946177] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:815; }","duration":"260.945948ms","start":"2026-03-31T18:22:17.258446Z","end":"2026-03-31T18:22:17.519392Z","steps":["trace[1668946177] 'agreement among raft nodes before linearized reading' (duration: 260.855776ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.520443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.767013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:17.520647Z","caller":"traceutil/trace.go:171","msg":"trace[770911241] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:815; }","duration":"470.007646ms","start":"2026-03-31T18:22:17.050631Z","end":"2026-03-31T18:22:17.520639Z","steps":["trace[770911241] 'agreement among raft nodes before linearized reading' (duration: 469.765212ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.520688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:17.050608Z","time spent":"470.070637ms","remote":"127.0.0.1:41450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-03-31T18:22:17.520695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.001456ms","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-03-31T18:22:17.520749Z","caller":"traceutil/trace.go:171","msg":"trace[2030027320] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:815; }","duration":"470.083747ms","start":"2026-03-31T18:22:17.050656Z","end":"2026-03-31T18:22:17.520739Z","steps":["trace[2030027320] 'agreement among raft nodes before linearized reading' (duration: 470.001276ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.520754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.383257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:17.520766Z","caller":"traceutil/trace.go:171","msg":"trace[1873907560] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:815; }","duration":"447.876186ms","start":"2026-03-31T18:22:17.072879Z","end":"2026-03-31T18:22:17.520756Z","steps":["trace[1873907560] 'agreement among raft nodes before linearized reading' (duration: 447.624153ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.520787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:17.050637Z","time spent":"470.141498ms","remote":"127.0.0.1:41450","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-03-31T18:22:17.520802Z","caller":"traceutil/trace.go:171","msg":"trace[1298733466] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:815; }","duration":"469.444488ms","start":"2026-03-31T18:22:17.051345Z","end":"2026-03-31T18:22:17.520789Z","steps":["trace[1298733466] 'agreement among raft nodes before linearized reading' (duration: 469.370057ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.520815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:17.072869Z","time spent":"447.934607ms","remote":"127.0.0.1:41454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 "} {"level":"warn","ts":"2026-03-31T18:22:17.520848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:17.05134Z","time spent":"469.498619ms","remote":"127.0.0.1:41450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-03-31T18:22:17.519207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:16.89456Z","time spent":"624.639967ms","remote":"127.0.0.1:41400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-03-31T18:22:17.520353Z","caller":"traceutil/trace.go:171","msg":"trace[1343418364] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:815; }","duration":"553.137169ms","start":"2026-03-31T18:22:16.967185Z","end":"2026-03-31T18:22:17.520322Z","steps":["trace[1343418364] 'agreement among raft nodes before linearized reading' (duration: 552.965377ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.521525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:16.967173Z","time spent":"554.335286ms","remote":"127.0.0.1:41424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-03-31T18:22:17.519282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.770555ms","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-03-31T18:22:17.521656Z","caller":"traceutil/trace.go:171","msg":"trace[1882789129] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:815; }","duration":"263.143569ms","start":"2026-03-31T18:22:17.25849Z","end":"2026-03-31T18:22:17.521633Z","steps":["trace[1882789129] 'agreement among raft nodes before linearized reading' (duration: 260.749735ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.519046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.390605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T18:22:17.519587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:17.015808Z","time spent":"503.737483ms","remote":"127.0.0.1:41436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"info","ts":"2026-03-31T18:22:17.519061Z","caller":"traceutil/trace.go:171","msg":"trace[874876973] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:815; }","duration":"275.761501ms","start":"2026-03-31T18:22:17.243234Z","end":"2026-03-31T18:22:17.518995Z","steps":["trace[874876973] 'agreement among raft nodes before linearized reading' (duration: 275.545078ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:17.521828Z","caller":"traceutil/trace.go:171","msg":"trace[975423209] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:815; }","duration":"325.180986ms","start":"2026-03-31T18:22:17.196622Z","end":"2026-03-31T18:22:17.521803Z","steps":["trace[975423209] 'agreement among raft nodes before linearized reading' (duration: 322.404586ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.522463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:17.196602Z","time spent":"325.841245ms","remote":"127.0.0.1:41496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"info","ts":"2026-03-31T18:22:17.519786Z","caller":"traceutil/trace.go:171","msg":"trace[200757092] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:815; }","duration":"323.153786ms","start":"2026-03-31T18:22:17.196623Z","end":"2026-03-31T18:22:17.519777Z","steps":["trace[200757092] 'agreement among raft nodes before linearized reading' (duration: 322.359475ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.522958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:17.196605Z","time spent":"326.333002ms","remote":"127.0.0.1:41496","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-03-31T18:22:17.520024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:16.805202Z","time spent":"714.809795ms","remote":"127.0.0.1:41372","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/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-03-31T18:22:17.519714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:16.770438Z","time spent":"749.267184ms","remote":"127.0.0.1:41362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"info","ts":"2026-03-31T18:22:17.519256Z","caller":"traceutil/trace.go:171","msg":"trace[1050194064] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:815; }","duration":"502.949002ms","start":"2026-03-31T18:22:17.016298Z","end":"2026-03-31T18:22:17.519247Z","steps":["trace[1050194064] 'agreement among raft nodes before linearized reading' (duration: 502.80924ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.523296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:17.016266Z","time spent":"507.018571ms","remote":"127.0.0.1:41436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-03-31T18:22:17.518966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:16.951987Z","time spent":"566.97026ms","remote":"127.0.0.1:41416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"info","ts":"2026-03-31T18:22:17.51896Z","caller":"traceutil/trace.go:171","msg":"trace[15918823] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:815; }","duration":"394.157951ms","start":"2026-03-31T18:22:17.124784Z","end":"2026-03-31T18:22:17.518942Z","steps":["trace[15918823] 'agreement among raft nodes before linearized reading' (duration: 394.019109ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.523602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:17.124779Z","time spent":"398.810998ms","remote":"127.0.0.1:41474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-03-31T18:22:17.51907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:16.925307Z","time spent":"593.755769ms","remote":"127.0.0.1:41414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-03-31T18:22:17.518972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.476393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:17.523955Z","caller":"traceutil/trace.go:171","msg":"trace[1106568020] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:815; }","duration":"571.454065ms","start":"2026-03-31T18:22:16.952378Z","end":"2026-03-31T18:22:17.523832Z","steps":["trace[1106568020] 'agreement among raft nodes before linearized reading' (duration: 566.451113ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.519091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.140471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T18:22:17.524011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:16.952311Z","time spent":"571.679258ms","remote":"127.0.0.1:41416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-03-31T18:22:17.524627Z","caller":"traceutil/trace.go:171","msg":"trace[1026713890] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:815; }","duration":"372.669531ms","start":"2026-03-31T18:22:17.151941Z","end":"2026-03-31T18:22:17.52461Z","steps":["trace[1026713890] 'agreement among raft nodes before linearized reading' (duration: 367.120831ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.524762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:17.151929Z","time spent":"372.753842ms","remote":"127.0.0.1:41480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"warn","ts":"2026-03-31T18:22:17.519103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.989438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:17.524903Z","caller":"traceutil/trace.go:171","msg":"trace[869172521] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:815; }","duration":"248.778772ms","start":"2026-03-31T18:22:17.276098Z","end":"2026-03-31T18:22:17.524877Z","steps":["trace[869172521] 'agreement among raft nodes before linearized reading' (duration: 242.921507ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.519119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.81872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:17.525122Z","caller":"traceutil/trace.go:171","msg":"trace[1744690035] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:815; }","duration":"599.841706ms","start":"2026-03-31T18:22:16.92527Z","end":"2026-03-31T18:22:17.525111Z","steps":["trace[1744690035] 'agreement among raft nodes before linearized reading' (duration: 593.83045ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.525219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:16.925254Z","time spent":"599.895587ms","remote":"127.0.0.1:41414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-03-31T18:22:17.519151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.065169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:17.525369Z","caller":"traceutil/trace.go:171","msg":"trace[2090951976] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:815; }","duration":"249.30707ms","start":"2026-03-31T18:22:17.27605Z","end":"2026-03-31T18:22:17.525357Z","steps":["trace[2090951976] 'agreement among raft nodes before linearized reading' (duration: 243.04924ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.519208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:17.151614Z","time spent":"367.585617ms","remote":"127.0.0.1:41480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"warn","ts":"2026-03-31T18:22:17.519219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.408295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:17.527631Z","caller":"traceutil/trace.go:171","msg":"trace[350672848] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:815; }","duration":"267.814856ms","start":"2026-03-31T18:22:17.259802Z","end":"2026-03-31T18:22:17.527617Z","steps":["trace[350672848] 'agreement among raft nodes before linearized reading' (duration: 259.389435ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:17.519286Z","caller":"traceutil/trace.go:171","msg":"trace[1251429916] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:815; }","duration":"625.137064ms","start":"2026-03-31T18:22:16.894141Z","end":"2026-03-31T18:22:17.519278Z","steps":["trace[1251429916] 'agreement among raft nodes before linearized reading' (duration: 625.094654ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.527854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:16.894126Z","time spent":"633.710948ms","remote":"127.0.0.1:41400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-03-31T18:22:17.519295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.723919ms","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-03-31T18:22:17.528091Z","caller":"traceutil/trace.go:171","msg":"trace[1570839806] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:815; }","duration":"376.536656ms","start":"2026-03-31T18:22:17.151545Z","end":"2026-03-31T18:22:17.528081Z","steps":["trace[1570839806] 'agreement among raft nodes before linearized reading' (duration: 367.730689ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.528187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:17.151529Z","time spent":"376.648509ms","remote":"127.0.0.1:41480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-03-31T18:22:17.519599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.381262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:17.528374Z","caller":"traceutil/trace.go:171","msg":"trace[1777629449] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:815; }","duration":"686.160218ms","start":"2026-03-31T18:22:16.842203Z","end":"2026-03-31T18:22:17.528363Z","steps":["trace[1777629449] 'agreement among raft nodes before linearized reading' (duration: 677.378732ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.528422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:16.842187Z","time spent":"686.224299ms","remote":"127.0.0.1:41388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-03-31T18:22:17.51964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.761877ms","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-03-31T18:22:17.528588Z","caller":"traceutil/trace.go:171","msg":"trace[497521586] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:815; }","duration":"686.748596ms","start":"2026-03-31T18:22:16.84183Z","end":"2026-03-31T18:22:17.528578Z","steps":["trace[497521586] 'agreement among raft nodes before linearized reading' (duration: 677.791687ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.528618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:16.841803Z","time spent":"686.799228ms","remote":"127.0.0.1:41388","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/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-03-31T18:22:17.519756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:16.770671Z","time spent":"749.075582ms","remote":"127.0.0.1:41362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"warn","ts":"2026-03-31T18:22:17.519823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.141945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:17.528911Z","caller":"traceutil/trace.go:171","msg":"trace[480911368] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:815; }","duration":"404.241207ms","start":"2026-03-31T18:22:17.124653Z","end":"2026-03-31T18:22:17.528894Z","steps":["trace[480911368] 'agreement among raft nodes before linearized reading' (duration: 395.124405ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.52897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:17.124648Z","time spent":"404.303998ms","remote":"127.0.0.1:41474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-03-31T18:22:17.519971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:17.124584Z","time spent":"395.377749ms","remote":"127.0.0.1:41474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-03-31T18:22:17.520045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:16.841714Z","time spent":"678.319885ms","remote":"127.0.0.1:41388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"info","ts":"2026-03-31T18:22:17.520052Z","caller":"traceutil/trace.go:171","msg":"trace[1763465188] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:815; }","duration":"419.641089ms","start":"2026-03-31T18:22:17.100399Z","end":"2026-03-31T18:22:17.52004Z","steps":["trace[1763465188] 'agreement among raft nodes before linearized reading' (duration: 419.592588ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.529188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:17.100376Z","time spent":"428.795231ms","remote":"127.0.0.1:41458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"info","ts":"2026-03-31T18:22:17.520126Z","caller":"traceutil/trace.go:171","msg":"trace[1765838435] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:815; }","duration":"420.581022ms","start":"2026-03-31T18:22:17.099537Z","end":"2026-03-31T18:22:17.520118Z","steps":["trace[1765838435] 'agreement among raft nodes before linearized reading' (duration: 420.534152ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.529268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:17.099527Z","time spent":"429.719724ms","remote":"127.0.0.1:41458","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-03-31T18:22:17.520107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.692913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:17.529353Z","caller":"traceutil/trace.go:171","msg":"trace[1079794187] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:815; }","duration":"562.101388ms","start":"2026-03-31T18:22:16.967238Z","end":"2026-03-31T18:22:17.529339Z","steps":["trace[1079794187] 'agreement among raft nodes before linearized reading' (duration: 552.701183ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.529373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:16.967223Z","time spent":"562.14282ms","remote":"127.0.0.1:41424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"info","ts":"2026-03-31T18:22:17.520289Z","caller":"traceutil/trace.go:171","msg":"trace[1585398457] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:815; }","duration":"447.240367ms","start":"2026-03-31T18:22:17.073005Z","end":"2026-03-31T18:22:17.520246Z","steps":["trace[1585398457] 'agreement among raft nodes before linearized reading' (duration: 447.031014ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:17.529482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:17.072984Z","time spent":"456.48917ms","remote":"127.0.0.1:41454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"info","ts":"2026-03-31T18:22:18.674579Z","caller":"traceutil/trace.go:171","msg":"trace[1534439770] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"191.447651ms","start":"2026-03-31T18:22:18.483104Z","end":"2026-03-31T18:22:18.674552Z","steps":["trace[1534439770] 'process raft request' (duration: 191.303388ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:52.421403Z","caller":"traceutil/trace.go:171","msg":"trace[1729293517] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"141.482818ms","start":"2026-03-31T18:22:52.279888Z","end":"2026-03-31T18:22:52.42137Z","steps":["trace[1729293517] 'process raft request' (duration: 141.277955ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:58.342426Z","caller":"traceutil/trace.go:171","msg":"trace[1914672868] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"228.520557ms","start":"2026-03-31T18:22:58.113877Z","end":"2026-03-31T18:22:58.342398Z","steps":["trace[1914672868] 'process raft request' (duration: 228.469536ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:58.343093Z","caller":"traceutil/trace.go:171","msg":"trace[110876863] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"229.429208ms","start":"2026-03-31T18:22:58.11365Z","end":"2026-03-31T18:22:58.343079Z","steps":["trace[110876863] 'process raft request' (duration: 228.521927ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:23:18.596664Z","caller":"traceutil/trace.go:171","msg":"trace[1182861352] linearizableReadLoop","detail":"{readStateIndex:1194; appliedIndex:1193; }","duration":"162.353738ms","start":"2026-03-31T18:23:18.434285Z","end":"2026-03-31T18:23:18.596638Z","steps":["trace[1182861352] 'read index received' (duration: 97.614043ms)","trace[1182861352] 'applied index is now lower than readState.Index' (duration: 64.738745ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:23:18.596915Z","caller":"traceutil/trace.go:171","msg":"trace[923135661] transaction","detail":"{read_only:false; response_revision:1151; number_of_response:1; }","duration":"166.983672ms","start":"2026-03-31T18:23:18.429872Z","end":"2026-03-31T18:23:18.596855Z","steps":["trace[923135661] 'process raft request' (duration: 102.017375ms)","trace[923135661] 'compare' (duration: 64.600903ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:23:18.597176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.814103ms","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-03-31T18:23:18.597226Z","caller":"traceutil/trace.go:171","msg":"trace[17490894] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1151; }","duration":"162.985726ms","start":"2026-03-31T18:23:18.434225Z","end":"2026-03-31T18:23:18.597211Z","steps":["trace[17490894] 'agreement among raft nodes before linearized reading' (duration: 162.704952ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:24:04.518392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.279507ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:24:04.518527Z","caller":"traceutil/trace.go:171","msg":"trace[1414594421] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"134.307944ms","start":"2026-03-31T18:24:04.384201Z","end":"2026-03-31T18:24:04.518509Z","steps":["trace[1414594421] 'compare' (duration: 128.144386ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:24:12.535544Z","caller":"traceutil/trace.go:171","msg":"trace[116318683] transaction","detail":"{read_only:false; response_revision:1364; number_of_response:1; }","duration":"165.028896ms","start":"2026-03-31T18:24:12.37049Z","end":"2026-03-31T18:24:12.535518Z","steps":["trace[116318683] 'process raft request' (duration: 164.880074ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:24:12.560652Z","caller":"traceutil/trace.go:171","msg":"trace[1001980818] transaction","detail":"{read_only:false; response_revision:1365; number_of_response:1; }","duration":"159.499155ms","start":"2026-03-31T18:24:12.401127Z","end":"2026-03-31T18:24:12.560626Z","steps":["trace[1001980818] 'process raft request' (duration: 159.365953ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:24:13.312385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.896024ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:24:13.312512Z","caller":"traceutil/trace.go:171","msg":"trace[72167787] transaction","detail":"{read_only:false; response_revision:1369; number_of_response:1; }","duration":"195.260882ms","start":"2026-03-31T18:24:13.117239Z","end":"2026-03-31T18:24:13.3125Z","steps":["trace[72167787] 'process raft request' (duration: 195.225262ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:24:13.312678Z","caller":"traceutil/trace.go:171","msg":"trace[797997105] linearizableReadLoop","detail":"{readStateIndex:1423; appliedIndex:1422; }","duration":"366.886219ms","start":"2026-03-31T18:24:12.945784Z","end":"2026-03-31T18:24:13.312671Z","steps":["trace[797997105] 'read index received' (duration: 27.594351ms)","trace[797997105] 'applied index is now lower than readState.Index' (duration: 339.291028ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:24:13.312725Z","caller":"traceutil/trace.go:171","msg":"trace[1332735129] transaction","detail":"{read_only:false; response_revision:1368; number_of_response:1; }","duration":"400.033589ms","start":"2026-03-31T18:24:12.912642Z","end":"2026-03-31T18:24:13.312676Z","steps":["trace[1332735129] 'process raft request' (duration: 60.784131ms)","trace[1332735129] 'compare' (duration: 338.810633ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:24:13.312833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.043981ms","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-03-31T18:24:13.3129Z","caller":"traceutil/trace.go:171","msg":"trace[376835503] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1369; }","duration":"367.134121ms","start":"2026-03-31T18:24:12.945759Z","end":"2026-03-31T18:24:13.312893Z","steps":["trace[376835503] 'agreement among raft nodes before linearized reading' (duration: 366.97413ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:24:13.312926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:24:12.945743Z","time spent":"367.177622ms","remote":"127.0.0.1:37330","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-03-31T18:24:13.31295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:24:12.912629Z","time spent":"400.188631ms","remote":"127.0.0.1:37330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:24:13.31304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.335592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:24:13.313063Z","caller":"traceutil/trace.go:171","msg":"trace[297425415] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1369; }","duration":"240.383903ms","start":"2026-03-31T18:24:13.072673Z","end":"2026-03-31T18:24:13.313057Z","steps":["trace[297425415] 'agreement among raft nodes before linearized reading' (duration: 240.349633ms)"],"step_count":1}