{"level":"warn","ts":"2026-08-04T15:11:37.57314Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-04T15:11:37.573217Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.180:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.180:2380","--initial-cluster=instance=https://199.19.213.180:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.180:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.180: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-08-04T15:11:37.573341Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-04T15:11:37.573355Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.180:2380"]} {"level":"info","ts":"2026-08-04T15:11:37.573376Z","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-08-04T15:11:37.573954Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.180:2379"]} {"level":"info","ts":"2026-08-04T15:11:37.574039Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.180:2380"],"listen-peer-urls":["https://199.19.213.180:2380"],"advertise-client-urls":["https://199.19.213.180:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.180:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.180: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-08-04T15:11:37.578595Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.309464ms"} {"level":"info","ts":"2026-08-04T15:11:37.585223Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5d6864bfaf2cb565","cluster-id":"32ff95319ee9cd99"} {"level":"info","ts":"2026-08-04T15:11:37.58536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d6864bfaf2cb565 switched to configuration voters=()"} {"level":"info","ts":"2026-08-04T15:11:37.585395Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d6864bfaf2cb565 became follower at term 0"} {"level":"info","ts":"2026-08-04T15:11:37.585411Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5d6864bfaf2cb565 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-04T15:11:37.58542Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d6864bfaf2cb565 became follower at term 1"} {"level":"info","ts":"2026-08-04T15:11:37.585458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d6864bfaf2cb565 switched to configuration voters=(6730740417545680229)"} {"level":"warn","ts":"2026-08-04T15:11:37.595378Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-04T15:11:37.597826Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-04T15:11:37.599993Z","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-08-04T15:11:37.602948Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5d6864bfaf2cb565","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-04T15:11:37.603132Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5d6864bfaf2cb565","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-04T15:11:37.603261Z","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-08-04T15:11:37.604551Z","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-08-04T15:11:37.604598Z","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-08-04T15:11:37.604879Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d6864bfaf2cb565 switched to configuration voters=(6730740417545680229)"} {"level":"info","ts":"2026-08-04T15:11:37.604994Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"32ff95319ee9cd99","local-member-id":"5d6864bfaf2cb565","added-peer-id":"5d6864bfaf2cb565","added-peer-peer-urls":["https://199.19.213.180:2380"]} {"level":"info","ts":"2026-08-04T15:11:37.606886Z","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-08-04T15:11:37.607049Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5d6864bfaf2cb565","initial-advertise-peer-urls":["https://199.19.213.180:2380"],"listen-peer-urls":["https://199.19.213.180:2380"],"advertise-client-urls":["https://199.19.213.180:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.180:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-04T15:11:37.607077Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-04T15:11:37.607123Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.180:2380"} {"level":"info","ts":"2026-08-04T15:11:37.607132Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.180:2380"} {"level":"info","ts":"2026-08-04T15:11:38.586137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d6864bfaf2cb565 is starting a new election at term 1"} {"level":"info","ts":"2026-08-04T15:11:38.586205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d6864bfaf2cb565 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-04T15:11:38.58623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d6864bfaf2cb565 received MsgPreVoteResp from 5d6864bfaf2cb565 at term 1"} {"level":"info","ts":"2026-08-04T15:11:38.586244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d6864bfaf2cb565 became candidate at term 2"} {"level":"info","ts":"2026-08-04T15:11:38.58625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d6864bfaf2cb565 received MsgVoteResp from 5d6864bfaf2cb565 at term 2"} {"level":"info","ts":"2026-08-04T15:11:38.586258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d6864bfaf2cb565 became leader at term 2"} {"level":"info","ts":"2026-08-04T15:11:38.586265Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5d6864bfaf2cb565 elected leader 5d6864bfaf2cb565 at term 2"} {"level":"info","ts":"2026-08-04T15:11:38.587168Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5d6864bfaf2cb565","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.180:2379]}","request-path":"/0/members/5d6864bfaf2cb565/attributes","cluster-id":"32ff95319ee9cd99","publish-timeout":"7s"} {"level":"info","ts":"2026-08-04T15:11:38.587181Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-04T15:11:38.587216Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-04T15:11:38.587386Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-04T15:11:38.587428Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-04T15:11:38.587375Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T15:11:38.588909Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"32ff95319ee9cd99","local-member-id":"5d6864bfaf2cb565","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T15:11:38.589106Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T15:11:38.589209Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T15:11:38.590606Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.180:2379"} {"level":"info","ts":"2026-08-04T15:11:38.591309Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-04T15:11:41.165971Z","caller":"traceutil/trace.go:171","msg":"trace[1966759174] linearizableReadLoop","detail":"{readStateIndex:84; appliedIndex:83; }","duration":"215.017929ms","start":"2026-08-04T15:11:40.950924Z","end":"2026-08-04T15:11:41.165942Z","steps":["trace[1966759174] 'read index received' (duration: 209.645241ms)","trace[1966759174] 'applied index is now lower than readState.Index' (duration: 5.371378ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:11:41.166153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.20034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-04T15:11:41.166202Z","caller":"traceutil/trace.go:171","msg":"trace[23038503] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:80; }","duration":"215.29323ms","start":"2026-08-04T15:11:40.950898Z","end":"2026-08-04T15:11:41.166191Z","steps":["trace[23038503] 'agreement among raft nodes before linearized reading' (duration: 215.15628ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:11:41.166417Z","caller":"traceutil/trace.go:171","msg":"trace[708602923] transaction","detail":"{read_only:false; response_revision:80; number_of_response:1; }","duration":"294.179863ms","start":"2026-08-04T15:11:40.872136Z","end":"2026-08-04T15:11:41.166315Z","steps":["trace[708602923] 'process raft request' (duration: 288.558295ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:11:44.046367Z","caller":"traceutil/trace.go:171","msg":"trace[642745282] transaction","detail":"{read_only:false; response_revision:245; number_of_response:1; }","duration":"113.595359ms","start":"2026-08-04T15:11:43.932742Z","end":"2026-08-04T15:11:44.046337Z","steps":["trace[642745282] 'process raft request' (duration: 69.636102ms)","trace[642745282] 'compare' (duration: 43.757446ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:11:44.458378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.208362ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:11:44.458679Z","caller":"traceutil/trace.go:171","msg":"trace[1734209221] linearizableReadLoop","detail":"{readStateIndex:265; appliedIndex:263; }","duration":"159.612753ms","start":"2026-08-04T15:11:44.299044Z","end":"2026-08-04T15:11:44.458656Z","steps":["trace[1734209221] 'read index received' (duration: 26.461129ms)","trace[1734209221] 'applied index is now lower than readState.Index' (duration: 133.150144ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:11:44.45887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.781144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-08-04T15:11:44.458867Z","caller":"traceutil/trace.go:171","msg":"trace[1087609909] transaction","detail":"{read_only:false; response_revision:256; number_of_response:1; }","duration":"193.865168ms","start":"2026-08-04T15:11:44.264968Z","end":"2026-08-04T15:11:44.458833Z","steps":["trace[1087609909] 'process raft request' (duration: 60.622193ms)","trace[1087609909] 'compare' (duration: 132.004581ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:11:44.458969Z","caller":"traceutil/trace.go:171","msg":"trace[1175331942] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:257; }","duration":"159.880394ms","start":"2026-08-04T15:11:44.299029Z","end":"2026-08-04T15:11:44.458909Z","steps":["trace[1175331942] 'agreement among raft nodes before linearized reading' (duration: 159.741743ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:11:44.458921Z","caller":"traceutil/trace.go:171","msg":"trace[1434569103] transaction","detail":"{read_only:false; response_revision:257; number_of_response:1; }","duration":"193.361456ms","start":"2026-08-04T15:11:44.265495Z","end":"2026-08-04T15:11:44.458857Z","steps":["trace[1434569103] 'process raft request' (duration: 193.012205ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:11:44.847609Z","caller":"traceutil/trace.go:171","msg":"trace[1090217653] linearizableReadLoop","detail":"{readStateIndex:272; appliedIndex:271; }","duration":"110.7591ms","start":"2026-08-04T15:11:44.736822Z","end":"2026-08-04T15:11:44.847581Z","steps":["trace[1090217653] 'read index received' (duration: 16.105163ms)","trace[1090217653] 'applied index is now lower than readState.Index' (duration: 94.652537ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:11:44.847626Z","caller":"traceutil/trace.go:171","msg":"trace[250250583] transaction","detail":"{read_only:false; response_revision:264; number_of_response:1; }","duration":"146.393879ms","start":"2026-08-04T15:11:44.701209Z","end":"2026-08-04T15:11:44.847603Z","steps":["trace[250250583] 'process raft request' (duration: 51.702182ms)","trace[250250583] 'compare' (duration: 94.548846ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:11:44.847784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2920"} {"level":"info","ts":"2026-08-04T15:11:44.847829Z","caller":"traceutil/trace.go:171","msg":"trace[1589463909] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:264; }","duration":"111.05305ms","start":"2026-08-04T15:11:44.736767Z","end":"2026-08-04T15:11:44.84782Z","steps":["trace[1589463909] 'agreement among raft nodes before linearized reading' (duration: 110.90676ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:11:44.875739Z","caller":"traceutil/trace.go:171","msg":"trace[2069299259] transaction","detail":"{read_only:false; number_of_response:0; response_revision:264; }","duration":"136.914068ms","start":"2026-08-04T15:11:44.738805Z","end":"2026-08-04T15:11:44.875719Z","steps":["trace[2069299259] 'process raft request' (duration: 136.817597ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:11:44.98187Z","caller":"traceutil/trace.go:171","msg":"trace[357383361] linearizableReadLoop","detail":"{readStateIndex:274; appliedIndex:273; }","duration":"105.506253ms","start":"2026-08-04T15:11:44.876334Z","end":"2026-08-04T15:11:44.98184Z","steps":["trace[357383361] 'read index received' (duration: 98.881671ms)","trace[357383361] 'applied index is now lower than readState.Index' (duration: 6.623082ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:11:44.981991Z","caller":"traceutil/trace.go:171","msg":"trace[635111500] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"118.963587ms","start":"2026-08-04T15:11:44.862991Z","end":"2026-08-04T15:11:44.981954Z","steps":["trace[635111500] 'process raft request' (duration: 112.255705ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:11:44.982105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.740224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5897"} {"level":"warn","ts":"2026-08-04T15:11:44.98214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.806927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-08-04T15:11:44.982166Z","caller":"traceutil/trace.go:171","msg":"trace[71345742] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:265; }","duration":"105.844944ms","start":"2026-08-04T15:11:44.876305Z","end":"2026-08-04T15:11:44.98215Z","steps":["trace[71345742] 'agreement among raft nodes before linearized reading' (duration: 105.704384ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:11:44.982209Z","caller":"traceutil/trace.go:171","msg":"trace[590443030] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:265; }","duration":"103.889347ms","start":"2026-08-04T15:11:44.878303Z","end":"2026-08-04T15:11:44.982192Z","steps":["trace[590443030] 'agreement among raft nodes before linearized reading' (duration: 103.750007ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:11:45.225509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.626592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"warn","ts":"2026-08-04T15:11:45.225523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.350731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3466"} {"level":"info","ts":"2026-08-04T15:11:45.225572Z","caller":"traceutil/trace.go:171","msg":"trace[143149980] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:267; }","duration":"141.735803ms","start":"2026-08-04T15:11:45.08382Z","end":"2026-08-04T15:11:45.225556Z","steps":["trace[143149980] 'range keys from in-memory index tree' (duration: 141.531212ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:11:45.225595Z","caller":"traceutil/trace.go:171","msg":"trace[294896558] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:267; }","duration":"141.440332ms","start":"2026-08-04T15:11:45.084136Z","end":"2026-08-04T15:11:45.225576Z","steps":["trace[294896558] 'range keys from in-memory index tree' (duration: 141.259851ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:11:45.330487Z","caller":"traceutil/trace.go:171","msg":"trace[432466304] transaction","detail":"{read_only:false; response_revision:268; number_of_response:1; }","duration":"101.715621ms","start":"2026-08-04T15:11:45.228753Z","end":"2026-08-04T15:11:45.330468Z","steps":["trace[432466304] 'process raft request' (duration: 101.58741ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:11:45.421663Z","caller":"traceutil/trace.go:171","msg":"trace[523241622] transaction","detail":"{read_only:false; response_revision:269; number_of_response:1; }","duration":"187.672136ms","start":"2026-08-04T15:11:45.23395Z","end":"2026-08-04T15:11:45.421622Z","steps":["trace[523241622] 'process raft request' (duration: 187.453336ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:11:46.699169Z","caller":"traceutil/trace.go:171","msg":"trace[1218817043] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"429.829966ms","start":"2026-08-04T15:11:46.269315Z","end":"2026-08-04T15:11:46.699145Z","steps":["trace[1218817043] 'process raft request' (duration: 429.699006ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:11:46.699499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:11:46.269298Z","time spent":"429.939196ms","remote":"127.0.0.1:36600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:11:47.811237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.656038ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:11:47.811339Z","caller":"traceutil/trace.go:171","msg":"trace[415129011] linearizableReadLoop","detail":"{readStateIndex:297; appliedIndex:296; }","duration":"1.346072086s","start":"2026-08-04T15:11:46.46525Z","end":"2026-08-04T15:11:47.811322Z","steps":["trace[415129011] 'read index received' (duration: 233.962741ms)","trace[415129011] 'applied index is now lower than readState.Index' (duration: 1.112108085s)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:11:47.811394Z","caller":"traceutil/trace.go:171","msg":"trace[1307157232] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"1.494711242s","start":"2026-08-04T15:11:46.316644Z","end":"2026-08-04T15:11:47.811355Z","steps":["trace[1307157232] 'process raft request' (duration: 988.868523ms)","trace[1307157232] 'compare' (duration: 505.535378ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:11:47.811436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.346189466s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-08-04T15:11:47.81147Z","caller":"traceutil/trace.go:171","msg":"trace[647744653] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:288; }","duration":"1.346261906s","start":"2026-08-04T15:11:46.465199Z","end":"2026-08-04T15:11:47.811461Z","steps":["trace[647744653] 'agreement among raft nodes before linearized reading' (duration: 1.346169536s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:11:47.811507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:11:46.46518Z","time spent":"1.346317786s","remote":"127.0.0.1:36600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-04T15:11:47.811544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:11:46.316623Z","time spent":"1.494849002s","remote":"127.0.0.1:36552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":201,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-04T15:11:48.319739Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13071029197748204451,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-04T15:11:48.8206Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13071029197748204451,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-04T15:11:49.102974Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.287119409s","expected-duration":"1s"} {"level":"info","ts":"2026-08-04T15:11:49.162705Z","caller":"traceutil/trace.go:171","msg":"trace[441427061] linearizableReadLoop","detail":"{readStateIndex:298; appliedIndex:297; }","duration":"1.343914979s","start":"2026-08-04T15:11:47.818728Z","end":"2026-08-04T15:11:49.162643Z","steps":["trace[441427061] 'read index received' (duration: 1.284472399s)","trace[441427061] 'applied index is now lower than readState.Index' (duration: 59.44095ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:11:49.162767Z","caller":"traceutil/trace.go:171","msg":"trace[847621233] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"1.347001199s","start":"2026-08-04T15:11:47.815732Z","end":"2026-08-04T15:11:49.162734Z","steps":["trace[847621233] 'process raft request' (duration: 1.28748625s)","trace[847621233] 'compare' (duration: 59.246638ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:11:49.162916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.34417111s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"warn","ts":"2026-08-04T15:11:49.162904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:11:47.8157Z","time spent":"1.347128969s","remote":"127.0.0.1:36600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:11:49.162962Z","caller":"traceutil/trace.go:171","msg":"trace[1149525494] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:289; }","duration":"1.34426884s","start":"2026-08-04T15:11:47.818678Z","end":"2026-08-04T15:11:49.162947Z","steps":["trace[1149525494] 'agreement among raft nodes before linearized reading' (duration: 1.344163259s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:11:49.163006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:11:47.81866Z","time spent":"1.34433528s","remote":"127.0.0.1:36552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":238,"request content":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" "} {"level":"warn","ts":"2026-08-04T15:11:49.163109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.031776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-08-04T15:11:49.163116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.074550979s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-08-04T15:11:49.163104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.096147781s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-04T15:11:49.163148Z","caller":"traceutil/trace.go:171","msg":"trace[2104396414] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:289; }","duration":"460.102537ms","start":"2026-08-04T15:11:48.703029Z","end":"2026-08-04T15:11:49.163132Z","steps":["trace[2104396414] 'agreement among raft nodes before linearized reading' (duration: 460.023867ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:11:49.163202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:11:48.702999Z","time spent":"460.196687ms","remote":"127.0.0.1:36600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-04T15:11:49.163204Z","caller":"traceutil/trace.go:171","msg":"trace[1861178852] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:289; }","duration":"1.096295962s","start":"2026-08-04T15:11:48.066887Z","end":"2026-08-04T15:11:49.163183Z","steps":["trace[1861178852] 'agreement among raft nodes before linearized reading' (duration: 1.096120142s)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:11:49.163204Z","caller":"traceutil/trace.go:171","msg":"trace[1244117634] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:289; }","duration":"1.074667619s","start":"2026-08-04T15:11:48.088512Z","end":"2026-08-04T15:11:49.163179Z","steps":["trace[1244117634] 'agreement among raft nodes before linearized reading' (duration: 1.074527479s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:11:49.16318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"819.366327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-04T15:11:49.163264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:11:48.066851Z","time spent":"1.096399943s","remote":"127.0.0.1:36600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-04T15:11:49.163264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:11:48.088491Z","time spent":"1.07476037s","remote":"127.0.0.1:36600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-04T15:11:49.163304Z","caller":"traceutil/trace.go:171","msg":"trace[1765783704] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:289; }","duration":"819.532248ms","start":"2026-08-04T15:11:48.343739Z","end":"2026-08-04T15:11:49.163271Z","steps":["trace[1765783704] 'agreement among raft nodes before linearized reading' (duration: 819.306087ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:11:49.16338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:11:48.343712Z","time spent":"819.654818ms","remote":"127.0.0.1:36320","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-08-04T15:11:49.670174Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13071029197748204457,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-04T15:11:49.916581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.902224ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:11:49.916682Z","caller":"traceutil/trace.go:171","msg":"trace[543243334] transaction","detail":"{read_only:false; response_revision:290; number_of_response:1; }","duration":"749.124853ms","start":"2026-08-04T15:11:49.167538Z","end":"2026-08-04T15:11:49.916662Z","steps":["trace[543243334] 'process raft request' (duration: 553.063748ms)","trace[543243334] 'compare' (duration: 195.186611ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:11:49.916745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:11:49.16752Z","time spent":"749.195733ms","remote":"127.0.0.1:36600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:11:49.9362Z","caller":"traceutil/trace.go:171","msg":"trace[1290141154] transaction","detail":"{read_only:false; response_revision:291; number_of_response:1; }","duration":"767.838594ms","start":"2026-08-04T15:11:49.168266Z","end":"2026-08-04T15:11:49.936105Z","steps":["trace[1290141154] 'process raft request' (duration: 767.285121ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:11:49.936593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:11:49.168258Z","time spent":"768.036394ms","remote":"127.0.0.1:36600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:11:49.9377Z","caller":"traceutil/trace.go:171","msg":"trace[463417293] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"768.841447ms","start":"2026-08-04T15:11:49.168822Z","end":"2026-08-04T15:11:49.937664Z","steps":["trace[463417293] 'process raft request' (duration: 767.151332ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:11:49.937813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:11:49.168794Z","time spent":"768.961208ms","remote":"127.0.0.1:36600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:11:49.938571Z","caller":"traceutil/trace.go:171","msg":"trace[517104556] linearizableReadLoop","detail":"{readStateIndex:302; appliedIndex:298; }","duration":"768.886468ms","start":"2026-08-04T15:11:49.169634Z","end":"2026-08-04T15:11:49.938521Z","steps":["trace[517104556] 'read index received' (duration: 550.91395ms)","trace[517104556] 'applied index is now lower than readState.Index' (duration: 217.970268ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:11:49.938874Z","caller":"traceutil/trace.go:171","msg":"trace[286509666] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"765.291427ms","start":"2026-08-04T15:11:49.17355Z","end":"2026-08-04T15:11:49.938842Z","steps":["trace[286509666] 'process raft request' (duration: 763.844132ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:11:49.939175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:11:49.173531Z","time spent":"765.401537ms","remote":"127.0.0.1:36534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7288,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:11:49.939472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.879279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:11:49.939538Z","caller":"traceutil/trace.go:171","msg":"trace[1911848382] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:293; }","duration":"301.995839ms","start":"2026-08-04T15:11:49.637526Z","end":"2026-08-04T15:11:49.939522Z","steps":["trace[1911848382] 'agreement among raft nodes before linearized reading' (duration: 301.898849ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:11:49.939624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:11:49.637503Z","time spent":"302.115129ms","remote":"127.0.0.1:36320","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-08-04T15:11:49.939714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"770.041681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:11:49.939833Z","caller":"traceutil/trace.go:171","msg":"trace[1693271251] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:0; response_revision:293; }","duration":"770.148812ms","start":"2026-08-04T15:11:49.16963Z","end":"2026-08-04T15:11:49.939778Z","steps":["trace[1693271251] 'agreement among raft nodes before linearized reading' (duration: 769.896831ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:11:49.939886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:11:49.169578Z","time spent":"770.297932ms","remote":"127.0.0.1:36552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"warn","ts":"2026-08-04T15:12:34.375307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"778.790356ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:12:34.375469Z","caller":"traceutil/trace.go:171","msg":"trace[214319578] linearizableReadLoop","detail":"{readStateIndex:511; appliedIndex:509; }","duration":"736.572675ms","start":"2026-08-04T15:12:33.638873Z","end":"2026-08-04T15:12:34.375446Z","steps":["trace[214319578] 'read index received' (duration: 42.51µs)","trace[214319578] 'applied index is now lower than readState.Index' (duration: 736.529145ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:12:34.375569Z","caller":"traceutil/trace.go:171","msg":"trace[1301539834] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"798.628022ms","start":"2026-08-04T15:12:33.57693Z","end":"2026-08-04T15:12:34.375558Z","steps":["trace[1301539834] 'process raft request' (duration: 798.470341ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:34.375565Z","caller":"traceutil/trace.go:171","msg":"trace[854201333] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"798.730683ms","start":"2026-08-04T15:12:33.576801Z","end":"2026-08-04T15:12:34.375532Z","steps":["trace[854201333] 'process raft request' (duration: 19.655966ms)","trace[854201333] 'compare' (duration: 778.641705ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:12:34.375625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:33.576913Z","time spent":"798.686893ms","remote":"127.0.0.1:36552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-04T15:12:34.375639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:33.576776Z","time spent":"798.829223ms","remote":"127.0.0.1:36552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":505,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-04T15:12:34.37585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.947758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:12:34.375922Z","caller":"traceutil/trace.go:171","msg":"trace[1654941525] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:492; }","duration":"737.071218ms","start":"2026-08-04T15:12:33.638832Z","end":"2026-08-04T15:12:34.375903Z","steps":["trace[1654941525] 'agreement among raft nodes before linearized reading' (duration: 736.930277ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:34.375966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:33.638811Z","time spent":"737.146809ms","remote":"127.0.0.1:36320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-04T15:12:34.599548Z","caller":"traceutil/trace.go:171","msg":"trace[1411302020] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"219.754942ms","start":"2026-08-04T15:12:34.379763Z","end":"2026-08-04T15:12:34.599518Z","steps":["trace[1411302020] 'process raft request' (duration: 219.659902ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:34.59958Z","caller":"traceutil/trace.go:171","msg":"trace[1506257843] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"219.872852ms","start":"2026-08-04T15:12:34.379672Z","end":"2026-08-04T15:12:34.599544Z","steps":["trace[1506257843] 'process raft request' (duration: 136.486085ms)","trace[1506257843] 'compare' (duration: 83.127837ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:12:34.599662Z","caller":"traceutil/trace.go:171","msg":"trace[1309234845] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"219.11683ms","start":"2026-08-04T15:12:34.380526Z","end":"2026-08-04T15:12:34.599643Z","steps":["trace[1309234845] 'process raft request' (duration: 219.048539ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:34.599682Z","caller":"traceutil/trace.go:171","msg":"trace[1735741355] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"219.639052ms","start":"2026-08-04T15:12:34.380021Z","end":"2026-08-04T15:12:34.59966Z","steps":["trace[1735741355] 'process raft request' (duration: 219.445011ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:36.882042Z","caller":"traceutil/trace.go:171","msg":"trace[1973656211] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"167.545069ms","start":"2026-08-04T15:12:36.714455Z","end":"2026-08-04T15:12:36.882Z","steps":["trace[1973656211] 'process raft request' (duration: 110.393379ms)","trace[1973656211] 'compare' (duration: 56.826889ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:12:36.88239Z","caller":"traceutil/trace.go:171","msg":"trace[889423633] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"161.366767ms","start":"2026-08-04T15:12:36.721005Z","end":"2026-08-04T15:12:36.882372Z","steps":["trace[889423633] 'process raft request' (duration: 161.020716ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:36.882399Z","caller":"traceutil/trace.go:171","msg":"trace[449055719] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"159.257411ms","start":"2026-08-04T15:12:36.723112Z","end":"2026-08-04T15:12:36.88237Z","steps":["trace[449055719] 'process raft request' (duration: 159.103511ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:36.885699Z","caller":"traceutil/trace.go:171","msg":"trace[1834421221] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"138.430151ms","start":"2026-08-04T15:12:36.747247Z","end":"2026-08-04T15:12:36.885677Z","steps":["trace[1834421221] 'process raft request' (duration: 138.334111ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:37.06217Z","caller":"traceutil/trace.go:171","msg":"trace[192422658] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"150.41807ms","start":"2026-08-04T15:12:36.911728Z","end":"2026-08-04T15:12:37.062146Z","steps":["trace[192422658] 'process raft request' (duration: 106.846026ms)","trace[192422658] 'compare' (duration: 43.423343ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:12:37.066876Z","caller":"traceutil/trace.go:171","msg":"trace[921947718] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"107.060957ms","start":"2026-08-04T15:12:36.959785Z","end":"2026-08-04T15:12:37.066846Z","steps":["trace[921947718] 'process raft request' (duration: 106.905226ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:37.403789Z","caller":"traceutil/trace.go:171","msg":"trace[1017181301] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"229.544495ms","start":"2026-08-04T15:12:37.174202Z","end":"2026-08-04T15:12:37.403747Z","steps":["trace[1017181301] 'process raft request' (duration: 229.270384ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:37.40391Z","caller":"traceutil/trace.go:171","msg":"trace[1590229051] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"191.577648ms","start":"2026-08-04T15:12:37.212308Z","end":"2026-08-04T15:12:37.403886Z","steps":["trace[1590229051] 'process raft request' (duration: 191.397948ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:37.404085Z","caller":"traceutil/trace.go:171","msg":"trace[719564385] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"187.732426ms","start":"2026-08-04T15:12:37.216337Z","end":"2026-08-04T15:12:37.404069Z","steps":["trace[719564385] 'process raft request' (duration: 187.505754ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:37.579689Z","caller":"traceutil/trace.go:171","msg":"trace[382080791] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"156.492281ms","start":"2026-08-04T15:12:37.423167Z","end":"2026-08-04T15:12:37.57966Z","steps":["trace[382080791] 'process raft request' (duration: 73.795516ms)","trace[382080791] 'compare' (duration: 82.564515ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:12:37.581431Z","caller":"traceutil/trace.go:171","msg":"trace[1152398558] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"106.922307ms","start":"2026-08-04T15:12:37.47449Z","end":"2026-08-04T15:12:37.581412Z","steps":["trace[1152398558] 'process raft request' (duration: 106.658436ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:37.628919Z","caller":"traceutil/trace.go:171","msg":"trace[229822013] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"109.892576ms","start":"2026-08-04T15:12:37.518979Z","end":"2026-08-04T15:12:37.628872Z","steps":["trace[229822013] 'process raft request' (duration: 109.628745ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:38.057996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.106314ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:12:38.058346Z","caller":"traceutil/trace.go:171","msg":"trace[678657855] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"152.358967ms","start":"2026-08-04T15:12:37.90595Z","end":"2026-08-04T15:12:38.058309Z","steps":["trace[678657855] 'process raft request' (duration: 39.873562ms)","trace[678657855] 'compare' (duration: 111.937113ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:12:38.058524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.311227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:12:38.058558Z","caller":"traceutil/trace.go:171","msg":"trace[373194103] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:0; response_revision:609; }","duration":"146.365718ms","start":"2026-08-04T15:12:37.912182Z","end":"2026-08-04T15:12:38.058548Z","steps":["trace[373194103] 'agreement among raft nodes before linearized reading' (duration: 146.290797ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:38.05859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.740319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-04T15:12:38.058625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.761589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:12:38.058771Z","caller":"traceutil/trace.go:171","msg":"trace[1022862928] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:0; response_revision:609; }","duration":"146.928249ms","start":"2026-08-04T15:12:37.911811Z","end":"2026-08-04T15:12:38.058739Z","steps":["trace[1022862928] 'agreement among raft nodes before linearized reading' (duration: 146.650558ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:38.05888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.28367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:12:38.058924Z","caller":"traceutil/trace.go:171","msg":"trace[1080980581] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:609; }","duration":"147.361591ms","start":"2026-08-04T15:12:37.911548Z","end":"2026-08-04T15:12:38.058909Z","steps":["trace[1080980581] 'agreement among raft nodes before linearized reading' (duration: 147.308061ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:38.058668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.903939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:12:38.058984Z","caller":"traceutil/trace.go:171","msg":"trace[1575176413] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"140.295687ms","start":"2026-08-04T15:12:37.918673Z","end":"2026-08-04T15:12:38.058968Z","steps":["trace[1575176413] 'process raft request' (duration: 139.719375ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:38.059039Z","caller":"traceutil/trace.go:171","msg":"trace[1798990029] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:609; }","duration":"147.31368ms","start":"2026-08-04T15:12:37.911719Z","end":"2026-08-04T15:12:38.059032Z","steps":["trace[1798990029] 'agreement among raft nodes before linearized reading' (duration: 146.895959ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:38.058685Z","caller":"traceutil/trace.go:171","msg":"trace[1336838731] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:609; }","duration":"146.891049ms","start":"2026-08-04T15:12:37.911768Z","end":"2026-08-04T15:12:38.058659Z","steps":["trace[1336838731] 'agreement among raft nodes before linearized reading' (duration: 146.716778ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:38.059099Z","caller":"traceutil/trace.go:171","msg":"trace[128912120] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"136.463994ms","start":"2026-08-04T15:12:37.922625Z","end":"2026-08-04T15:12:38.059089Z","steps":["trace[128912120] 'process raft request' (duration: 136.263364ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:38.058537Z","caller":"traceutil/trace.go:171","msg":"trace[1176955188] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:631; }","duration":"144.48145ms","start":"2026-08-04T15:12:37.913961Z","end":"2026-08-04T15:12:38.058442Z","steps":["trace[1176955188] 'read index received' (duration: 31.875705ms)","trace[1176955188] 'applied index is now lower than readState.Index' (duration: 112.603535ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:12:38.059488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.771142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:12:38.059524Z","caller":"traceutil/trace.go:171","msg":"trace[1521338497] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:0; response_revision:611; }","duration":"144.818312ms","start":"2026-08-04T15:12:37.914692Z","end":"2026-08-04T15:12:38.05951Z","steps":["trace[1521338497] 'agreement among raft nodes before linearized reading' (duration: 144.763391ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:38.059627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.550665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:12:38.059706Z","caller":"traceutil/trace.go:171","msg":"trace[190850925] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:611; }","duration":"139.625815ms","start":"2026-08-04T15:12:37.920059Z","end":"2026-08-04T15:12:38.059685Z","steps":["trace[190850925] 'agreement among raft nodes before linearized reading' (duration: 139.551785ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:38.059792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.10331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:12:38.059826Z","caller":"traceutil/trace.go:171","msg":"trace[632855201] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:611; }","duration":"141.1543ms","start":"2026-08-04T15:12:37.918664Z","end":"2026-08-04T15:12:38.059818Z","steps":["trace[632855201] 'agreement among raft nodes before linearized reading' (duration: 141.10568ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:38.059539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.020807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:12:38.059903Z","caller":"traceutil/trace.go:171","msg":"trace[363054126] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:611; }","duration":"137.397748ms","start":"2026-08-04T15:12:37.922498Z","end":"2026-08-04T15:12:38.059896Z","steps":["trace[363054126] 'agreement among raft nodes before linearized reading' (duration: 136.952795ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:38.059588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.046514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:12:38.059986Z","caller":"traceutil/trace.go:171","msg":"trace[1066097898] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:611; }","duration":"106.463735ms","start":"2026-08-04T15:12:37.953506Z","end":"2026-08-04T15:12:38.05997Z","steps":["trace[1066097898] 'agreement among raft nodes before linearized reading' (duration: 106.064934ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:38.314224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.306343ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:12:38.314338Z","caller":"traceutil/trace.go:171","msg":"trace[1755019750] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"194.689458ms","start":"2026-08-04T15:12:38.119632Z","end":"2026-08-04T15:12:38.314321Z","steps":["trace[1755019750] 'read index received' (duration: 55.046673ms)","trace[1755019750] 'applied index is now lower than readState.Index' (duration: 139.641595ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:12:38.314377Z","caller":"traceutil/trace.go:171","msg":"trace[1304239848] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"194.758488ms","start":"2026-08-04T15:12:38.119591Z","end":"2026-08-04T15:12:38.31435Z","steps":["trace[1304239848] 'process raft request' (duration: 55.243754ms)","trace[1304239848] 'compare' (duration: 139.138353ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:12:38.314666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.01922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:59631"} {"level":"info","ts":"2026-08-04T15:12:38.314719Z","caller":"traceutil/trace.go:171","msg":"trace[836019462] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:612; }","duration":"195.10539ms","start":"2026-08-04T15:12:38.119599Z","end":"2026-08-04T15:12:38.314705Z","steps":["trace[836019462] 'agreement among raft nodes before linearized reading' (duration: 194.832089ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:38.375577Z","caller":"traceutil/trace.go:171","msg":"trace[1796674318] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"129.11466ms","start":"2026-08-04T15:12:38.246394Z","end":"2026-08-04T15:12:38.375509Z","steps":["trace[1796674318] 'process raft request' (duration: 125.689339ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:38.599549Z","caller":"traceutil/trace.go:171","msg":"trace[1673394856] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"288.391142ms","start":"2026-08-04T15:12:38.311097Z","end":"2026-08-04T15:12:38.599488Z","steps":["trace[1673394856] 'process raft request' (duration: 194.060478ms)","trace[1673394856] 'compare' (duration: 94.011743ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:12:38.599662Z","caller":"traceutil/trace.go:171","msg":"trace[1019464839] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:635; }","duration":"268.608155ms","start":"2026-08-04T15:12:38.331005Z","end":"2026-08-04T15:12:38.599613Z","steps":["trace[1019464839] 'read index received' (duration: 40.575406ms)","trace[1019464839] 'applied index is now lower than readState.Index' (duration: 228.031899ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:12:38.599764Z","caller":"traceutil/trace.go:171","msg":"trace[440805621] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"231.353481ms","start":"2026-08-04T15:12:38.368367Z","end":"2026-08-04T15:12:38.599721Z","steps":["trace[440805621] 'process raft request' (duration: 231.01753ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:38.599892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.845666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:80703"} {"level":"info","ts":"2026-08-04T15:12:38.599939Z","caller":"traceutil/trace.go:171","msg":"trace[487571309] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:615; }","duration":"268.941086ms","start":"2026-08-04T15:12:38.330985Z","end":"2026-08-04T15:12:38.599926Z","steps":["trace[487571309] 'agreement among raft nodes before linearized reading' (duration: 268.746026ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:38.607064Z","caller":"traceutil/trace.go:171","msg":"trace[400399108] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"189.176981ms","start":"2026-08-04T15:12:38.417858Z","end":"2026-08-04T15:12:38.607035Z","steps":["trace[400399108] 'process raft request' (duration: 189.066131ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:38.616283Z","caller":"traceutil/trace.go:171","msg":"trace[509314683] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"104.843459ms","start":"2026-08-04T15:12:38.511421Z","end":"2026-08-04T15:12:38.616264Z","steps":["trace[509314683] 'process raft request' (duration: 104.478928ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:38.778014Z","caller":"traceutil/trace.go:171","msg":"trace[1180424527] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"105.592952ms","start":"2026-08-04T15:12:38.672397Z","end":"2026-08-04T15:12:38.77799Z","steps":["trace[1180424527] 'process raft request' (duration: 105.484592ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:38.778254Z","caller":"traceutil/trace.go:171","msg":"trace[869183644] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"107.071667ms","start":"2026-08-04T15:12:38.671153Z","end":"2026-08-04T15:12:38.778225Z","steps":["trace[869183644] 'process raft request' (duration: 97.464285ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:38.778394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.799189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:151236"} {"level":"info","ts":"2026-08-04T15:12:38.778544Z","caller":"traceutil/trace.go:171","msg":"trace[1099972036] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:622; }","duration":"140.87966ms","start":"2026-08-04T15:12:38.637561Z","end":"2026-08-04T15:12:38.778441Z","steps":["trace[1099972036] 'agreement among raft nodes before linearized reading' (duration: 140.575479ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:38.972317Z","caller":"traceutil/trace.go:171","msg":"trace[404875952] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"100.390103ms","start":"2026-08-04T15:12:38.871906Z","end":"2026-08-04T15:12:38.972297Z","steps":["trace[404875952] 'read index received' (duration: 62.378397ms)","trace[404875952] 'applied index is now lower than readState.Index' (duration: 38.010716ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:12:38.972346Z","caller":"traceutil/trace.go:171","msg":"trace[1226689820] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"100.905537ms","start":"2026-08-04T15:12:38.871418Z","end":"2026-08-04T15:12:38.972323Z","steps":["trace[1226689820] 'process raft request' (duration: 62.92979ms)","trace[1226689820] 'compare' (duration: 37.789846ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:12:38.972501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.579534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31145"} {"level":"info","ts":"2026-08-04T15:12:38.972589Z","caller":"traceutil/trace.go:171","msg":"trace[548526658] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:629; }","duration":"100.680604ms","start":"2026-08-04T15:12:38.871897Z","end":"2026-08-04T15:12:38.972578Z","steps":["trace[548526658] 'agreement among raft nodes before linearized reading' (duration: 100.483524ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:39.018173Z","caller":"traceutil/trace.go:171","msg":"trace[1022683468] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"143.362898ms","start":"2026-08-04T15:12:38.87479Z","end":"2026-08-04T15:12:39.018153Z","steps":["trace[1022683468] 'process raft request' (duration: 143.232628ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:39.018317Z","caller":"traceutil/trace.go:171","msg":"trace[190296245] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"108.271432ms","start":"2026-08-04T15:12:38.910038Z","end":"2026-08-04T15:12:39.01831Z","steps":["trace[190296245] 'process raft request' (duration: 108.084591ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:39.235423Z","caller":"traceutil/trace.go:171","msg":"trace[275603447] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:659; }","duration":"112.560625ms","start":"2026-08-04T15:12:39.122838Z","end":"2026-08-04T15:12:39.235399Z","steps":["trace[275603447] 'read index received' (duration: 102.514662ms)","trace[275603447] 'applied index is now lower than readState.Index' (duration: 10.044563ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:12:39.235679Z","caller":"traceutil/trace.go:171","msg":"trace[363063167] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"121.806965ms","start":"2026-08-04T15:12:39.113844Z","end":"2026-08-04T15:12:39.235651Z","steps":["trace[363063167] 'process raft request' (duration: 111.468212ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:39.235889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.996776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:98713"} {"level":"info","ts":"2026-08-04T15:12:39.235972Z","caller":"traceutil/trace.go:171","msg":"trace[1699932729] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:637; }","duration":"113.106896ms","start":"2026-08-04T15:12:39.122821Z","end":"2026-08-04T15:12:39.235928Z","steps":["trace[1699932729] 'agreement among raft nodes before linearized reading' (duration: 112.688485ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:39.384059Z","caller":"traceutil/trace.go:171","msg":"trace[1592831173] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:660; }","duration":"115.030554ms","start":"2026-08-04T15:12:39.269003Z","end":"2026-08-04T15:12:39.384034Z","steps":["trace[1592831173] 'read index received' (duration: 114.724233ms)","trace[1592831173] 'applied index is now lower than readState.Index' (duration: 305.161µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:12:39.384136Z","caller":"traceutil/trace.go:171","msg":"trace[1463839538] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"122.533157ms","start":"2026-08-04T15:12:39.261574Z","end":"2026-08-04T15:12:39.384107Z","steps":["trace[1463839538] 'process raft request' (duration: 122.140236ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:39.384476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.448765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:65436"} {"level":"info","ts":"2026-08-04T15:12:39.384567Z","caller":"traceutil/trace.go:171","msg":"trace[1390099660] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:638; }","duration":"115.585356ms","start":"2026-08-04T15:12:39.268966Z","end":"2026-08-04T15:12:39.384552Z","steps":["trace[1390099660] 'agreement among raft nodes before linearized reading' (duration: 115.268344ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:39.423757Z","caller":"traceutil/trace.go:171","msg":"trace[931746433] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"113.173588ms","start":"2026-08-04T15:12:39.310562Z","end":"2026-08-04T15:12:39.423736Z","steps":["trace[931746433] 'process raft request' (duration: 113.084247ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:39.5729Z","caller":"traceutil/trace.go:171","msg":"trace[569233121] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:663; }","duration":"104.585229ms","start":"2026-08-04T15:12:39.46829Z","end":"2026-08-04T15:12:39.572875Z","steps":["trace[569233121] 'read index received' (duration: 70.457065ms)","trace[569233121] 'applied index is now lower than readState.Index' (duration: 34.125784ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:12:39.572958Z","caller":"traceutil/trace.go:171","msg":"trace[2063460274] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"144.045161ms","start":"2026-08-04T15:12:39.428887Z","end":"2026-08-04T15:12:39.572932Z","steps":["trace[2063460274] 'process raft request' (duration: 109.898177ms)","trace[2063460274] 'compare' (duration: 33.962704ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:12:39.573052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.737729ms","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-08-04T15:12:39.573084Z","caller":"traceutil/trace.go:171","msg":"trace[1972455851] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:641; }","duration":"104.82001ms","start":"2026-08-04T15:12:39.468256Z","end":"2026-08-04T15:12:39.573076Z","steps":["trace[1972455851] 'agreement among raft nodes before linearized reading' (duration: 104.737599ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:39.575344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.869567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoypatchpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:20866"} {"level":"info","ts":"2026-08-04T15:12:39.575421Z","caller":"traceutil/trace.go:171","msg":"trace[1345782631] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoypatchpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:642; }","duration":"106.965047ms","start":"2026-08-04T15:12:39.468437Z","end":"2026-08-04T15:12:39.575402Z","steps":["trace[1345782631] 'agreement among raft nodes before linearized reading' (duration: 106.735217ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:40.442375Z","caller":"traceutil/trace.go:171","msg":"trace[1879879681] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"277.988297ms","start":"2026-08-04T15:12:40.164365Z","end":"2026-08-04T15:12:40.442353Z","steps":["trace[1879879681] 'process raft request' (duration: 277.781526ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:40.45363Z","caller":"traceutil/trace.go:171","msg":"trace[200322204] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"106.492425ms","start":"2026-08-04T15:12:40.347113Z","end":"2026-08-04T15:12:40.453605Z","steps":["trace[200322204] 'process raft request' (duration: 106.074454ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:41.209486Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13071029197748205164,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-04T15:12:41.683089Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.012125523s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-04T15:12:41.702434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.060400695s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:12:41.702517Z","caller":"traceutil/trace.go:171","msg":"trace[1030067253] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:656; }","duration":"1.060522515s","start":"2026-08-04T15:12:40.641973Z","end":"2026-08-04T15:12:41.702496Z","steps":["trace[1030067253] 'range keys from in-memory index tree' (duration: 1.060334925s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:41.702553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:40.641952Z","time spent":"1.060592625s","remote":"127.0.0.1:36320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-04T15:12:41.702888Z","caller":"traceutil/trace.go:171","msg":"trace[570342994] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"1.03241802s","start":"2026-08-04T15:12:40.670429Z","end":"2026-08-04T15:12:41.702847Z","steps":["trace[570342994] 'process raft request' (duration: 1.012922435s)","trace[570342994] 'compare' (duration: 19.097034ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:12:41.703125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:40.670411Z","time spent":"1.032580551s","remote":"127.0.0.1:36378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188471,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:12:41.77316Z","caller":"traceutil/trace.go:171","msg":"trace[945142500] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"1.082506917s","start":"2026-08-04T15:12:40.690619Z","end":"2026-08-04T15:12:41.773126Z","steps":["trace[945142500] 'process raft request' (duration: 1.081984486s)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:41.773206Z","caller":"traceutil/trace.go:171","msg":"trace[1197255878] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"511.662474ms","start":"2026-08-04T15:12:41.261532Z","end":"2026-08-04T15:12:41.773194Z","steps":["trace[1197255878] 'process raft request' (duration: 511.465014ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:41.773383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:40.690582Z","time spent":"1.082658377s","remote":"127.0.0.1:36378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188237,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:12:41.773382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:41.261507Z","time spent":"511.735784ms","remote":"127.0.0.1:36600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:12:41.77308Z","caller":"traceutil/trace.go:171","msg":"trace[395242986] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:679; }","duration":"1.063665826s","start":"2026-08-04T15:12:40.709386Z","end":"2026-08-04T15:12:41.773051Z","steps":["trace[395242986] 'read index received' (duration: 973.969317ms)","trace[395242986] 'applied index is now lower than readState.Index' (duration: 89.695369ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:12:41.77388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.064491978s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-08-04T15:12:41.774527Z","caller":"traceutil/trace.go:171","msg":"trace[246878680] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:659; }","duration":"1.064647459s","start":"2026-08-04T15:12:40.70931Z","end":"2026-08-04T15:12:41.773958Z","steps":["trace[246878680] 'agreement among raft nodes before linearized reading' (duration: 1.064420358s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:41.774578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:40.709253Z","time spent":"1.065313731s","remote":"127.0.0.1:36378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":9342,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" "} {"level":"warn","ts":"2026-08-04T15:12:41.775403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"936.730752ms","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-08-04T15:12:41.775523Z","caller":"traceutil/trace.go:171","msg":"trace[977320587] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:659; }","duration":"936.931732ms","start":"2026-08-04T15:12:40.838571Z","end":"2026-08-04T15:12:41.775502Z","steps":["trace[977320587] 'agreement among raft nodes before linearized reading' (duration: 936.483701ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:41.775619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.783858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"warn","ts":"2026-08-04T15:12:41.775758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:40.838532Z","time spent":"937.148293ms","remote":"127.0.0.1:36600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-04T15:12:41.776501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.695009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-08-04T15:12:41.776637Z","caller":"traceutil/trace.go:171","msg":"trace[1082389635] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:659; }","duration":"467.823089ms","start":"2026-08-04T15:12:41.308754Z","end":"2026-08-04T15:12:41.776577Z","steps":["trace[1082389635] 'agreement among raft nodes before linearized reading' (duration: 467.653629ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:41.776776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:41.308732Z","time spent":"468.02813ms","remote":"127.0.0.1:36378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":13251,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"info","ts":"2026-08-04T15:12:41.775717Z","caller":"traceutil/trace.go:171","msg":"trace[60123643] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:659; }","duration":"266.971699ms","start":"2026-08-04T15:12:41.50872Z","end":"2026-08-04T15:12:41.775692Z","steps":["trace[60123643] 'agreement among raft nodes before linearized reading' (duration: 266.662768ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:41.776927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"906.577382ms","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-08-04T15:12:41.77698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.197565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-08-04T15:12:41.776984Z","caller":"traceutil/trace.go:171","msg":"trace[1551811024] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:659; }","duration":"906.671623ms","start":"2026-08-04T15:12:40.870297Z","end":"2026-08-04T15:12:41.776969Z","steps":["trace[1551811024] 'agreement among raft nodes before linearized reading' (duration: 906.533522ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:41.777034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:40.870275Z","time spent":"906.750633ms","remote":"127.0.0.1:36600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-04T15:12:41.777032Z","caller":"traceutil/trace.go:171","msg":"trace[1344382616] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:659; }","duration":"667.292595ms","start":"2026-08-04T15:12:41.109724Z","end":"2026-08-04T15:12:41.777016Z","steps":["trace[1344382616] 'agreement among raft nodes before linearized reading' (duration: 667.183744ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:41.77708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:41.109697Z","time spent":"667.374075ms","remote":"127.0.0.1:36378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":5199,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" "} {"level":"warn","ts":"2026-08-04T15:12:41.776875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"905.713399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-04T15:12:41.778059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"869.82577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:4333"} {"level":"info","ts":"2026-08-04T15:12:41.780062Z","caller":"traceutil/trace.go:171","msg":"trace[1452077324] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:659; }","duration":"871.818547ms","start":"2026-08-04T15:12:40.908202Z","end":"2026-08-04T15:12:41.780021Z","steps":["trace[1452077324] 'agreement among raft nodes before linearized reading' (duration: 869.565139ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:41.780145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:40.90819Z","time spent":"871.929687ms","remote":"127.0.0.1:36378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4355,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" "} {"level":"info","ts":"2026-08-04T15:12:41.779358Z","caller":"traceutil/trace.go:171","msg":"trace[286200661] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:659; }","duration":"908.242197ms","start":"2026-08-04T15:12:40.871086Z","end":"2026-08-04T15:12:41.779328Z","steps":["trace[286200661] 'agreement among raft nodes before linearized reading' (duration: 905.691098ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:41.785803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:40.871051Z","time spent":"914.737889ms","remote":"127.0.0.1:36600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-04T15:12:48.290517Z","caller":"traceutil/trace.go:171","msg":"trace[801659313] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"464.271098ms","start":"2026-08-04T15:12:47.826216Z","end":"2026-08-04T15:12:48.290487Z","steps":["trace[801659313] 'process raft request' (duration: 464.091228ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:48.290945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:47.826198Z","time spent":"464.576089ms","remote":"127.0.0.1:36600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:12:48.375935Z","caller":"traceutil/trace.go:171","msg":"trace[1033564742] linearizableReadLoop","detail":"{readStateIndex:733; appliedIndex:731; }","duration":"547.479864ms","start":"2026-08-04T15:12:47.828417Z","end":"2026-08-04T15:12:48.375897Z","steps":["trace[1033564742] 'read index received' (duration: 461.88133ms)","trace[1033564742] 'applied index is now lower than readState.Index' (duration: 85.597224ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:12:48.376039Z","caller":"traceutil/trace.go:171","msg":"trace[1340333378] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"548.686988ms","start":"2026-08-04T15:12:47.82727Z","end":"2026-08-04T15:12:48.375956Z","steps":["trace[1340333378] 'process raft request' (duration: 534.954402ms)","trace[1340333378] 'compare' (duration: 13.532956ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:12:48.376192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.671918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-04T15:12:48.376167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.719245ms","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-08-04T15:12:48.376244Z","caller":"traceutil/trace.go:171","msg":"trace[204157778] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:707; }","duration":"545.778559ms","start":"2026-08-04T15:12:47.830452Z","end":"2026-08-04T15:12:48.37623Z","steps":["trace[204157778] 'agreement among raft nodes before linearized reading' (duration: 545.651969ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:48.37627Z","caller":"traceutil/trace.go:171","msg":"trace[2058540466] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:707; }","duration":"547.854215ms","start":"2026-08-04T15:12:47.828392Z","end":"2026-08-04T15:12:48.376246Z","steps":["trace[2058540466] 'agreement among raft nodes before linearized reading' (duration: 547.663025ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:48.376338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:47.828381Z","time spent":"547.944646ms","remote":"127.0.0.1:36600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-04T15:12:48.37656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.269884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vfmns\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-04T15:12:48.376605Z","caller":"traceutil/trace.go:171","msg":"trace[1445200672] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vfmns; range_end:; response_count:1; response_revision:707; }","duration":"493.339564ms","start":"2026-08-04T15:12:47.883254Z","end":"2026-08-04T15:12:48.376594Z","steps":["trace[1445200672] 'agreement among raft nodes before linearized reading' (duration: 493.060783ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:48.376645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:47.88324Z","time spent":"493.397534ms","remote":"127.0.0.1:36534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-vfmns\" "} {"level":"warn","ts":"2026-08-04T15:12:48.376283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:47.827238Z","time spent":"548.92919ms","remote":"127.0.0.1:36600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:12:48.376289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:47.830441Z","time spent":"545.838559ms","remote":"127.0.0.1:36600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-04T15:12:48.377379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.813933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-04T15:12:48.377457Z","caller":"traceutil/trace.go:171","msg":"trace[797659756] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:707; }","duration":"276.940294ms","start":"2026-08-04T15:12:48.100499Z","end":"2026-08-04T15:12:48.377439Z","steps":["trace[797659756] 'agreement among raft nodes before linearized reading' (duration: 275.707379ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:48.517125Z","caller":"traceutil/trace.go:171","msg":"trace[1847480940] transaction","detail":"{read_only:false; response_revision:709; number_of_response:1; }","duration":"134.777761ms","start":"2026-08-04T15:12:48.382303Z","end":"2026-08-04T15:12:48.517081Z","steps":["trace[1847480940] 'process raft request' (duration: 107.258498ms)","trace[1847480940] 'compare' (duration: 27.352602ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:12:48.517179Z","caller":"traceutil/trace.go:171","msg":"trace[854866708] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"125.723789ms","start":"2026-08-04T15:12:48.391436Z","end":"2026-08-04T15:12:48.51716Z","steps":["trace[854866708] 'process raft request' (duration: 125.641738ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:48.517336Z","caller":"traceutil/trace.go:171","msg":"trace[317322943] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"133.372475ms","start":"2026-08-04T15:12:48.383953Z","end":"2026-08-04T15:12:48.517325Z","steps":["trace[317322943] 'process raft request' (duration: 133.062444ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:50.881474Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13071029197748205307,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-04T15:12:50.962771Z","caller":"traceutil/trace.go:171","msg":"trace[227920502] linearizableReadLoop","detail":"{readStateIndex:738; appliedIndex:737; }","duration":"581.530409ms","start":"2026-08-04T15:12:50.381221Z","end":"2026-08-04T15:12:50.962752Z","steps":["trace[227920502] 'read index received' (duration: 581.373089ms)","trace[227920502] 'applied index is now lower than readState.Index' (duration: 156.18µs)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:12:50.963278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.58138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:12:50.963353Z","caller":"traceutil/trace.go:171","msg":"trace[1990239120] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:712; }","duration":"152.69729ms","start":"2026-08-04T15:12:50.810635Z","end":"2026-08-04T15:12:50.963332Z","steps":["trace[1990239120] 'agreement among raft nodes before linearized reading' (duration: 152.527919ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:50.963409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.254201ms","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":"info","ts":"2026-08-04T15:12:50.963466Z","caller":"traceutil/trace.go:171","msg":"trace[1403357579] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:712; }","duration":"183.306981ms","start":"2026-08-04T15:12:50.780143Z","end":"2026-08-04T15:12:50.96345Z","steps":["trace[1403357579] 'agreement among raft nodes before linearized reading' (duration: 183.237081ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:50.963453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.716923ms","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":"warn","ts":"2026-08-04T15:12:50.963489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.576819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:12:50.963565Z","caller":"traceutil/trace.go:171","msg":"trace[1678533129] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:712; }","duration":"155.67003ms","start":"2026-08-04T15:12:50.807875Z","end":"2026-08-04T15:12:50.963545Z","steps":["trace[1678533129] 'agreement among raft nodes before linearized reading' (duration: 155.534939ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:50.963635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.842736ms","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-08-04T15:12:50.96369Z","caller":"traceutil/trace.go:171","msg":"trace[101212844] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:712; }","duration":"226.943466ms","start":"2026-08-04T15:12:50.736734Z","end":"2026-08-04T15:12:50.963677Z","steps":["trace[101212844] 'agreement among raft nodes before linearized reading' (duration: 226.860696ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:50.963711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.80796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-04T15:12:50.963745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.653762ms","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":"info","ts":"2026-08-04T15:12:50.963839Z","caller":"traceutil/trace.go:171","msg":"trace[950032660] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:712; }","duration":"183.771842ms","start":"2026-08-04T15:12:50.780054Z","end":"2026-08-04T15:12:50.963826Z","steps":["trace[950032660] 'agreement among raft nodes before linearized reading' (duration: 183.650492ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:50.963853Z","caller":"traceutil/trace.go:171","msg":"trace[1063008322] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:712; }","duration":"155.95401ms","start":"2026-08-04T15:12:50.807859Z","end":"2026-08-04T15:12:50.963813Z","steps":["trace[1063008322] 'agreement among raft nodes before linearized reading' (duration: 155.72682ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:50.963948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.194328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-04T15:12:50.963963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.185994ms","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":"info","ts":"2026-08-04T15:12:50.964Z","caller":"traceutil/trace.go:171","msg":"trace[139210575] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:712; }","duration":"548.281608ms","start":"2026-08-04T15:12:50.415706Z","end":"2026-08-04T15:12:50.963988Z","steps":["trace[139210575] 'agreement among raft nodes before linearized reading' (duration: 547.421375ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:50.964004Z","caller":"traceutil/trace.go:171","msg":"trace[1866732301] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:712; }","duration":"268.237404ms","start":"2026-08-04T15:12:50.695756Z","end":"2026-08-04T15:12:50.963993Z","steps":["trace[1866732301] 'agreement among raft nodes before linearized reading' (duration: 268.168214ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:50.964038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:50.415687Z","time spent":"548.342698ms","remote":"127.0.0.1:36600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-04T15:12:50.964046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.974246ms","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":"info","ts":"2026-08-04T15:12:50.964093Z","caller":"traceutil/trace.go:171","msg":"trace[1973415378] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:712; }","duration":"227.042737ms","start":"2026-08-04T15:12:50.737038Z","end":"2026-08-04T15:12:50.96408Z","steps":["trace[1973415378] 'agreement among raft nodes before linearized reading' (duration: 226.968417ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:50.964172Z","caller":"traceutil/trace.go:171","msg":"trace[1357161073] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"662.824728ms","start":"2026-08-04T15:12:50.30133Z","end":"2026-08-04T15:12:50.964155Z","steps":["trace[1357161073] 'process raft request' (duration: 661.318864ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:50.964202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.599565ms","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-08-04T15:12:50.963545Z","caller":"traceutil/trace.go:171","msg":"trace[741448081] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:712; }","duration":"267.829243ms","start":"2026-08-04T15:12:50.695691Z","end":"2026-08-04T15:12:50.96352Z","steps":["trace[741448081] 'agreement among raft nodes before linearized reading' (duration: 267.682813ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:50.964247Z","caller":"traceutil/trace.go:171","msg":"trace[632280673] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:712; }","duration":"268.661566ms","start":"2026-08-04T15:12:50.695563Z","end":"2026-08-04T15:12:50.964225Z","steps":["trace[632280673] 'agreement among raft nodes before linearized reading' (duration: 268.612545ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:50.96431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:50.301314Z","time spent":"662.913289ms","remote":"127.0.0.1:36600","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-08-04T15:12:50.964383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.939356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-04T15:12:50.964414Z","caller":"traceutil/trace.go:171","msg":"trace[1306783300] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:712; }","duration":"442.987746ms","start":"2026-08-04T15:12:50.521419Z","end":"2026-08-04T15:12:50.964406Z","steps":["trace[1306783300] 'agreement among raft nodes before linearized reading' (duration: 442.899046ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:50.964444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:50.521412Z","time spent":"443.025736ms","remote":"127.0.0.1:36600","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-08-04T15:12:50.964484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.362675ms","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":"warn","ts":"2026-08-04T15:12:50.964576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.996433ms","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":"warn","ts":"2026-08-04T15:12:50.964609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.115097ms","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-08-04T15:12:50.964619Z","caller":"traceutil/trace.go:171","msg":"trace[1940879396] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:712; }","duration":"127.082114ms","start":"2026-08-04T15:12:50.837524Z","end":"2026-08-04T15:12:50.964606Z","steps":["trace[1940879396] 'agreement among raft nodes before linearized reading' (duration: 127.013734ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:50.964641Z","caller":"traceutil/trace.go:171","msg":"trace[1545495400] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:712; }","duration":"101.176927ms","start":"2026-08-04T15:12:50.863456Z","end":"2026-08-04T15:12:50.964633Z","steps":["trace[1545495400] 'agreement among raft nodes before linearized reading' (duration: 101.132217ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:50.96464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.269268ms","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-08-04T15:12:50.964679Z","caller":"traceutil/trace.go:171","msg":"trace[375382516] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:712; }","duration":"101.345698ms","start":"2026-08-04T15:12:50.863324Z","end":"2026-08-04T15:12:50.96467Z","steps":["trace[375382516] 'agreement among raft nodes before linearized reading' (duration: 101.284978ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:50.964684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.461415ms","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-08-04T15:12:50.964773Z","caller":"traceutil/trace.go:171","msg":"trace[1366718740] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:712; }","duration":"583.595215ms","start":"2026-08-04T15:12:50.381171Z","end":"2026-08-04T15:12:50.964766Z","steps":["trace[1366718740] 'agreement among raft nodes before linearized reading' (duration: 583.415885ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:50.9647Z","caller":"traceutil/trace.go:171","msg":"trace[1492046527] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:712; }","duration":"100.586366ms","start":"2026-08-04T15:12:50.864008Z","end":"2026-08-04T15:12:50.964595Z","steps":["trace[1492046527] 'agreement among raft nodes before linearized reading' (duration: 100.350385ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:50.96481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:50.381153Z","time spent":"583.648235ms","remote":"127.0.0.1:36600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-04T15:12:50.963348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.495585ms","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-08-04T15:12:50.964925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.482845ms","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-08-04T15:12:50.964917Z","caller":"traceutil/trace.go:171","msg":"trace[563482301] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:712; }","duration":"228.08989ms","start":"2026-08-04T15:12:50.736811Z","end":"2026-08-04T15:12:50.964901Z","steps":["trace[563482301] 'agreement among raft nodes before linearized reading' (duration: 226.475015ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:50.964551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.309658ms","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-08-04T15:12:50.964961Z","caller":"traceutil/trace.go:171","msg":"trace[540231021] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:712; }","duration":"127.545545ms","start":"2026-08-04T15:12:50.837406Z","end":"2026-08-04T15:12:50.964952Z","steps":["trace[540231021] 'agreement among raft nodes before linearized reading' (duration: 127.495995ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:50.964973Z","caller":"traceutil/trace.go:171","msg":"trace[825626469] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:712; }","duration":"443.769939ms","start":"2026-08-04T15:12:50.521194Z","end":"2026-08-04T15:12:50.964964Z","steps":["trace[825626469] 'agreement among raft nodes before linearized reading' (duration: 443.305097ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:50.965007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:12:50.521171Z","time spent":"443.826029ms","remote":"127.0.0.1:36600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-04T15:12:50.965438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.738456ms","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":"info","ts":"2026-08-04T15:12:50.965503Z","caller":"traceutil/trace.go:171","msg":"trace[428387753] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:712; }","duration":"184.970916ms","start":"2026-08-04T15:12:50.780516Z","end":"2026-08-04T15:12:50.965487Z","steps":["trace[428387753] 'agreement among raft nodes before linearized reading' (duration: 184.549244ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:12:57.117401Z","caller":"traceutil/trace.go:171","msg":"trace[363508071] linearizableReadLoop","detail":"{readStateIndex:778; appliedIndex:776; }","duration":"122.820819ms","start":"2026-08-04T15:12:56.994546Z","end":"2026-08-04T15:12:57.117367Z","steps":["trace[363508071] 'read index received' (duration: 34.392214ms)","trace[363508071] 'applied index is now lower than readState.Index' (duration: 88.427185ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:12:57.117565Z","caller":"traceutil/trace.go:171","msg":"trace[705716722] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"167.428168ms","start":"2026-08-04T15:12:56.95012Z","end":"2026-08-04T15:12:57.117548Z","steps":["trace[705716722] 'process raft request' (duration: 148.944426ms)","trace[705716722] 'compare' (duration: 18.141711ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:12:57.117797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.23469ms","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-08-04T15:12:57.117894Z","caller":"traceutil/trace.go:171","msg":"trace[1769934178] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:751; }","duration":"123.334411ms","start":"2026-08-04T15:12:56.994532Z","end":"2026-08-04T15:12:57.117866Z","steps":["trace[1769934178] 'agreement among raft nodes before linearized reading' (duration: 123.12414ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:12:57.391558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.586852ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-08-04T15:13:05.396297Z","caller":"traceutil/trace.go:171","msg":"trace[2036579957] linearizableReadLoop","detail":"{readStateIndex:843; appliedIndex:842; }","duration":"186.567542ms","start":"2026-08-04T15:13:05.209703Z","end":"2026-08-04T15:13:05.396271Z","steps":["trace[2036579957] 'read index received' (duration: 186.445662ms)","trace[2036579957] 'applied index is now lower than readState.Index' (duration: 120.47µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:13:05.396411Z","caller":"traceutil/trace.go:171","msg":"trace[952868210] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"212.84757ms","start":"2026-08-04T15:13:05.183552Z","end":"2026-08-04T15:13:05.3964Z","steps":["trace[952868210] 'process raft request' (duration: 212.568139ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:05.396876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.121994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-08-04T15:13:05.396964Z","caller":"traceutil/trace.go:171","msg":"trace[16379365] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:813; }","duration":"187.265164ms","start":"2026-08-04T15:13:05.209675Z","end":"2026-08-04T15:13:05.39694Z","steps":["trace[16379365] 'agreement among raft nodes before linearized reading' (duration: 186.856753ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:13:05.397389Z","caller":"traceutil/trace.go:171","msg":"trace[552096604] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"179.827969ms","start":"2026-08-04T15:13:05.217543Z","end":"2026-08-04T15:13:05.397371Z","steps":["trace[552096604] 'process raft request' (duration: 179.466148ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:05.39739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.188353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-04T15:13:05.397466Z","caller":"traceutil/trace.go:171","msg":"trace[951623851] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:814; }","duration":"184.297523ms","start":"2026-08-04T15:13:05.213149Z","end":"2026-08-04T15:13:05.397447Z","steps":["trace[951623851] 'agreement among raft nodes before linearized reading' (duration: 183.984192ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:05.39783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.679705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-04T15:13:05.397876Z","caller":"traceutil/trace.go:171","msg":"trace[371837019] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:814; }","duration":"181.783666ms","start":"2026-08-04T15:13:05.216082Z","end":"2026-08-04T15:13:05.397866Z","steps":["trace[371837019] 'agreement among raft nodes before linearized reading' (duration: 181.668576ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:05.398175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.150787ms","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-08-04T15:13:05.398254Z","caller":"traceutil/trace.go:171","msg":"trace[545499038] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:814; }","duration":"182.276527ms","start":"2026-08-04T15:13:05.215959Z","end":"2026-08-04T15:13:05.398235Z","steps":["trace[545499038] 'agreement among raft nodes before linearized reading' (duration: 182.077897ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:09.017691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.379670598s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:13:09.017757Z","caller":"traceutil/trace.go:171","msg":"trace[801078596] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:831; }","duration":"1.379784949s","start":"2026-08-04T15:13:07.637957Z","end":"2026-08-04T15:13:09.017742Z","steps":["trace[801078596] 'range keys from in-memory index tree' (duration: 1.379527907s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:09.017787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:07.637936Z","time spent":"1.379845389s","remote":"127.0.0.1:36320","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-08-04T15:13:09.017875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.031657457s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-97lb2\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-08-04T15:13:09.018069Z","caller":"traceutil/trace.go:171","msg":"trace[1854328273] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-97lb2; range_end:; response_count:1; response_revision:831; }","duration":"1.031884838s","start":"2026-08-04T15:13:07.986164Z","end":"2026-08-04T15:13:09.018049Z","steps":["trace[1854328273] 'range keys from in-memory index tree' (duration: 1.031500347s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:09.018118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:07.986147Z","time spent":"1.031959238s","remote":"127.0.0.1:36534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-97lb2\" "} {"level":"warn","ts":"2026-08-04T15:13:09.018142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.770115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-04T15:13:09.018254Z","caller":"traceutil/trace.go:171","msg":"trace[235327516] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:831; }","duration":"566.276207ms","start":"2026-08-04T15:13:08.451951Z","end":"2026-08-04T15:13:09.018227Z","steps":["trace[235327516] 'count revisions from in-memory index tree' (duration: 565.665125ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:13:09.018334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:13:08.451931Z","time spent":"566.375327ms","remote":"127.0.0.1:36378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":31,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"info","ts":"2026-08-04T15:13:09.236004Z","caller":"traceutil/trace.go:171","msg":"trace[744746991] linearizableReadLoop","detail":"{readStateIndex:863; appliedIndex:862; }","duration":"208.747376ms","start":"2026-08-04T15:13:09.027227Z","end":"2026-08-04T15:13:09.235974Z","steps":["trace[744746991] 'read index received' (duration: 208.655856ms)","trace[744746991] 'applied index is now lower than readState.Index' (duration: 90.05µs)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:13:09.236129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.887767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:13:09.236154Z","caller":"traceutil/trace.go:171","msg":"trace[945274604] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:832; }","duration":"208.960337ms","start":"2026-08-04T15:13:09.027185Z","end":"2026-08-04T15:13:09.236146Z","steps":["trace[945274604] 'agreement among raft nodes before linearized reading' (duration: 208.897666ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:13:09.236153Z","caller":"traceutil/trace.go:171","msg":"trace[1814911706] transaction","detail":"{read_only:false; response_revision:832; number_of_response:1; }","duration":"209.889269ms","start":"2026-08-04T15:13:09.026203Z","end":"2026-08-04T15:13:09.236092Z","steps":["trace[1814911706] 'process raft request' (duration: 209.616259ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:30.625202Z","caller":"traceutil/trace.go:171","msg":"trace[279780282] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"111.29041ms","start":"2026-08-04T15:14:30.513886Z","end":"2026-08-04T15:14:30.625176Z","steps":["trace[279780282] 'process raft request' (duration: 111.060837ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:36.135461Z","caller":"traceutil/trace.go:171","msg":"trace[293834904] linearizableReadLoop","detail":"{readStateIndex:1300; appliedIndex:1297; }","duration":"215.26746ms","start":"2026-08-04T15:14:35.920137Z","end":"2026-08-04T15:14:36.135405Z","steps":["trace[293834904] 'read index received' (duration: 2.333929ms)","trace[293834904] 'applied index is now lower than readState.Index' (duration: 212.932381ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:14:36.135494Z","caller":"traceutil/trace.go:171","msg":"trace[1852454770] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"221.493004ms","start":"2026-08-04T15:14:35.91395Z","end":"2026-08-04T15:14:36.135443Z","steps":["trace[1852454770] 'process raft request' (duration: 147.520782ms)","trace[1852454770] 'compare' (duration: 73.735849ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:14:36.135654Z","caller":"traceutil/trace.go:171","msg":"trace[920982130] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"221.41664ms","start":"2026-08-04T15:14:35.914226Z","end":"2026-08-04T15:14:36.135642Z","steps":["trace[920982130] 'process raft request' (duration: 221.123244ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:14:36.135674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.508823ms","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-08-04T15:14:36.135719Z","caller":"traceutil/trace.go:171","msg":"trace[1906700020] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1251; }","duration":"215.594298ms","start":"2026-08-04T15:14:35.920109Z","end":"2026-08-04T15:14:36.135704Z","steps":["trace[1906700020] 'agreement among raft nodes before linearized reading' (duration: 215.429649ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:14:41.132779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.230671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-04T15:14:41.132871Z","caller":"traceutil/trace.go:171","msg":"trace[1957203970] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1266; }","duration":"115.387529ms","start":"2026-08-04T15:14:41.017465Z","end":"2026-08-04T15:14:41.132853Z","steps":["trace[1957203970] 'count revisions from in-memory index tree' (duration: 115.117615ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:50.969486Z","caller":"traceutil/trace.go:171","msg":"trace[755691410] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"136.313228ms","start":"2026-08-04T15:14:50.833145Z","end":"2026-08-04T15:14:50.969458Z","steps":["trace[755691410] 'process raft request' (duration: 134.58396ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:51.149175Z","caller":"traceutil/trace.go:171","msg":"trace[463601358] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"168.623856ms","start":"2026-08-04T15:14:50.980517Z","end":"2026-08-04T15:14:51.149141Z","steps":["trace[463601358] 'process raft request' (duration: 121.773384ms)","trace[463601358] 'compare' (duration: 46.652602ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:14:51.906234Z","caller":"traceutil/trace.go:171","msg":"trace[1734496038] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"134.292485ms","start":"2026-08-04T15:14:51.771917Z","end":"2026-08-04T15:14:51.90621Z","steps":["trace[1734496038] 'process raft request' (duration: 134.167978ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:51.90643Z","caller":"traceutil/trace.go:171","msg":"trace[467328630] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"139.928374ms","start":"2026-08-04T15:14:51.76642Z","end":"2026-08-04T15:14:51.906348Z","steps":["trace[467328630] 'process raft request' (duration: 134.415129ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:52.254303Z","caller":"traceutil/trace.go:171","msg":"trace[1362500380] linearizableReadLoop","detail":"{readStateIndex:1385; appliedIndex:1384; }","duration":"142.586654ms","start":"2026-08-04T15:14:52.111692Z","end":"2026-08-04T15:14:52.254279Z","steps":["trace[1362500380] 'read index received' (duration: 142.446517ms)","trace[1362500380] 'applied index is now lower than readState.Index' (duration: 139.397µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:14:52.254378Z","caller":"traceutil/trace.go:171","msg":"trace[907261300] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"154.642834ms","start":"2026-08-04T15:14:52.099724Z","end":"2026-08-04T15:14:52.254367Z","steps":["trace[907261300] 'process raft request' (duration: 154.458545ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:14:52.25457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.865119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/default/default\" ","response":"range_response_count:1 size:171"} {"level":"info","ts":"2026-08-04T15:14:52.254593Z","caller":"traceutil/trace.go:171","msg":"trace[1785965173] range","detail":"{range_begin:/registry/serviceaccounts/default/default; range_end:; response_count:1; response_revision:1331; }","duration":"142.932721ms","start":"2026-08-04T15:14:52.111656Z","end":"2026-08-04T15:14:52.254588Z","steps":["trace[1785965173] 'agreement among raft nodes before linearized reading' (duration: 142.827516ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:52.512246Z","caller":"traceutil/trace.go:171","msg":"trace[1738493587] linearizableReadLoop","detail":"{readStateIndex:1389; appliedIndex:1388; }","duration":"115.258276ms","start":"2026-08-04T15:14:52.396965Z","end":"2026-08-04T15:14:52.512223Z","steps":["trace[1738493587] 'read index received' (duration: 81.475518ms)","trace[1738493587] 'applied index is now lower than readState.Index' (duration: 33.781638ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:14:52.512675Z","caller":"traceutil/trace.go:171","msg":"trace[293806928] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"154.480965ms","start":"2026-08-04T15:14:52.358179Z","end":"2026-08-04T15:14:52.51266Z","steps":["trace[293806928] 'process raft request' (duration: 120.260435ms)","trace[293806928] 'compare' (duration: 33.636201ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:14:52.512624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.625975ms","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-08-04T15:14:52.512761Z","caller":"traceutil/trace.go:171","msg":"trace[413409898] 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:1335; }","duration":"115.825695ms","start":"2026-08-04T15:14:52.396917Z","end":"2026-08-04T15:14:52.512742Z","steps":["trace[413409898] 'agreement among raft nodes before linearized reading' (duration: 115.586763ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:52.845381Z","caller":"traceutil/trace.go:171","msg":"trace[651636466] transaction","detail":"{read_only:false; response_revision:1336; number_of_response:1; }","duration":"108.292331ms","start":"2026-08-04T15:14:52.737052Z","end":"2026-08-04T15:14:52.845345Z","steps":["trace[651636466] 'process raft request' (duration: 107.972785ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:56.545597Z","caller":"traceutil/trace.go:171","msg":"trace[1651086556] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"149.318598ms","start":"2026-08-04T15:14:56.396252Z","end":"2026-08-04T15:14:56.54557Z","steps":["trace[1651086556] 'process raft request' (duration: 123.207722ms)","trace[1651086556] 'compare' (duration: 25.99646ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:14:57.664439Z","caller":"traceutil/trace.go:171","msg":"trace[1651882198] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"369.296094ms","start":"2026-08-04T15:14:57.295116Z","end":"2026-08-04T15:14:57.664412Z","steps":["trace[1651882198] 'process raft request' (duration: 286.809779ms)","trace[1651882198] 'compare' (duration: 82.065665ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:14:57.664594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:14:57.295091Z","time spent":"369.42006ms","remote":"127.0.0.1:36600","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-08-04T15:14:57.856617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.467999ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-08-04T15:14:57.857284Z","caller":"traceutil/trace.go:171","msg":"trace[1596911608] linearizableReadLoop","detail":"{readStateIndex:1408; appliedIndex:1407; }","duration":"255.656658ms","start":"2026-08-04T15:14:57.601589Z","end":"2026-08-04T15:14:57.857246Z","steps":["trace[1596911608] 'read index received' (duration: 115.489254ms)","trace[1596911608] 'applied index is now lower than readState.Index' (duration: 140.165604ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:14:57.857349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.735762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-04T15:14:57.85741Z","caller":"traceutil/trace.go:171","msg":"trace[489665103] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1353; }","duration":"255.842997ms","start":"2026-08-04T15:14:57.601552Z","end":"2026-08-04T15:14:57.857395Z","steps":["trace[489665103] 'agreement among raft nodes before linearized reading' (duration: 255.726311ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:14:57.857505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.17433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:14:57.857604Z","caller":"traceutil/trace.go:171","msg":"trace[963010045] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1353; }","duration":"219.310966ms","start":"2026-08-04T15:14:57.63828Z","end":"2026-08-04T15:14:57.857591Z","steps":["trace[963010045] 'agreement among raft nodes before linearized reading' (duration: 219.106767ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:14:59.061751Z","caller":"traceutil/trace.go:171","msg":"trace[106302917] linearizableReadLoop","detail":"{readStateIndex:1413; appliedIndex:1412; }","duration":"337.174642ms","start":"2026-08-04T15:14:58.724551Z","end":"2026-08-04T15:14:59.061725Z","steps":["trace[106302917] 'read index received' (duration: 293.803047ms)","trace[106302917] 'applied index is now lower than readState.Index' (duration: 43.370144ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:14:59.061842Z","caller":"traceutil/trace.go:171","msg":"trace[2073242033] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"403.77523ms","start":"2026-08-04T15:14:58.65802Z","end":"2026-08-04T15:14:59.061796Z","steps":["trace[2073242033] 'process raft request' (duration: 360.310261ms)","trace[2073242033] 'compare' (duration: 43.190216ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:14:59.062013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:14:58.658004Z","time spent":"403.919816ms","remote":"127.0.0.1:36600","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-08-04T15:14:59.062083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.501587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:14:59.062181Z","caller":"traceutil/trace.go:171","msg":"trace[453469234] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1359; }","duration":"337.636783ms","start":"2026-08-04T15:14:58.724522Z","end":"2026-08-04T15:14:59.062158Z","steps":["trace[453469234] 'agreement among raft nodes before linearized reading' (duration: 337.302307ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:14:59.062236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:14:58.724466Z","time spent":"337.758079ms","remote":"127.0.0.1:36586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"info","ts":"2026-08-04T15:15:00.49701Z","caller":"traceutil/trace.go:171","msg":"trace[1064282814] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"118.202671ms","start":"2026-08-04T15:15:00.37874Z","end":"2026-08-04T15:15:00.496943Z","steps":["trace[1064282814] 'process raft request' (duration: 114.737158ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:15:00.711064Z","caller":"traceutil/trace.go:171","msg":"trace[1802828852] transaction","detail":"{read_only:false; response_revision:1362; number_of_response:1; }","duration":"209.866488ms","start":"2026-08-04T15:15:00.501173Z","end":"2026-08-04T15:15:00.711039Z","steps":["trace[1802828852] 'process raft request' (duration: 209.462129ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:15:02.85373Z","caller":"traceutil/trace.go:171","msg":"trace[366954643] transaction","detail":"{read_only:false; response_revision:1370; number_of_response:1; }","duration":"107.357598ms","start":"2026-08-04T15:15:02.746318Z","end":"2026-08-04T15:15:02.853675Z","steps":["trace[366954643] 'process raft request' (duration: 101.916273ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:15:04.647358Z","caller":"traceutil/trace.go:171","msg":"trace[604838340] transaction","detail":"{read_only:false; response_revision:1374; number_of_response:1; }","duration":"174.878334ms","start":"2026-08-04T15:15:04.472465Z","end":"2026-08-04T15:15:04.647343Z","steps":["trace[604838340] 'process raft request' (duration: 174.758389ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:15:05.050505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.226109ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:15:05.050614Z","caller":"traceutil/trace.go:171","msg":"trace[369145925] linearizableReadLoop","detail":"{readStateIndex:1434; appliedIndex:1432; }","duration":"194.162742ms","start":"2026-08-04T15:15:04.856438Z","end":"2026-08-04T15:15:05.050601Z","steps":["trace[369145925] 'read index received' (duration: 16.278832ms)","trace[369145925] 'applied index is now lower than readState.Index' (duration: 177.88272ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:15:05.050709Z","caller":"traceutil/trace.go:171","msg":"trace[1552929358] transaction","detail":"{read_only:false; response_revision:1378; number_of_response:1; }","duration":"210.745707ms","start":"2026-08-04T15:15:04.839939Z","end":"2026-08-04T15:15:05.050685Z","steps":["trace[1552929358] 'process raft request' (duration: 106.276657ms)","trace[1552929358] 'compare' (duration: 104.135005ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:15:05.050788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.345791ms","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-08-04T15:15:05.050851Z","caller":"traceutil/trace.go:171","msg":"trace[883461530] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1378; }","duration":"194.400263ms","start":"2026-08-04T15:15:04.856407Z","end":"2026-08-04T15:15:05.050807Z","steps":["trace[883461530] 'agreement among raft nodes before linearized reading' (duration: 194.272647ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:15:05.17844Z","caller":"traceutil/trace.go:171","msg":"trace[1923970713] transaction","detail":"{read_only:false; response_revision:1380; number_of_response:1; }","duration":"123.76272ms","start":"2026-08-04T15:15:05.054655Z","end":"2026-08-04T15:15:05.178418Z","steps":["trace[1923970713] 'process raft request' (duration: 123.586622ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:15:05.17884Z","caller":"traceutil/trace.go:171","msg":"trace[462219529] transaction","detail":"{read_only:false; response_revision:1379; number_of_response:1; }","duration":"132.144535ms","start":"2026-08-04T15:15:05.046196Z","end":"2026-08-04T15:15:05.17834Z","steps":["trace[462219529] 'process raft request' (duration: 108.058109ms)","trace[462219529] 'compare' (duration: 23.861696ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:15:05.560625Z","caller":"traceutil/trace.go:171","msg":"trace[2110236085] transaction","detail":"{read_only:false; response_revision:1383; number_of_response:1; }","duration":"148.235673ms","start":"2026-08-04T15:15:05.412367Z","end":"2026-08-04T15:15:05.560603Z","steps":["trace[2110236085] 'process raft request' (duration: 148.102597ms)"],"step_count":1}