{"level":"warn","ts":"2026-06-24T09:37:30.668111Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-24T09:37:30.668215Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.57: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.57:2380","--initial-cluster=instance=https://199.19.213.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.57:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-24T09:37:30.668297Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-24T09:37:30.668312Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.57:2380"]} {"level":"info","ts":"2026-06-24T09:37:30.668333Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-24T09:37:30.669074Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.57:2379"]} {"level":"info","ts":"2026-06-24T09:37:30.669152Z","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.57:2380"],"listen-peer-urls":["https://199.19.213.57:2380"],"advertise-client-urls":["https://199.19.213.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.57:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-24T09:37:30.673088Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.740673ms"} {"level":"info","ts":"2026-06-24T09:37:30.679959Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ef5ef2a9544a39ef","cluster-id":"58d35553a3d286c0"} {"level":"info","ts":"2026-06-24T09:37:30.680034Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ef5ef2a9544a39ef switched to configuration voters=()"} {"level":"info","ts":"2026-06-24T09:37:30.680054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ef5ef2a9544a39ef became follower at term 0"} {"level":"info","ts":"2026-06-24T09:37:30.680068Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ef5ef2a9544a39ef [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-24T09:37:30.680083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ef5ef2a9544a39ef became follower at term 1"} {"level":"info","ts":"2026-06-24T09:37:30.680124Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ef5ef2a9544a39ef switched to configuration voters=(17248490431953123823)"} {"level":"warn","ts":"2026-06-24T09:37:30.685946Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-24T09:37:30.687426Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-24T09:37:30.688854Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-24T09:37:30.691898Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ef5ef2a9544a39ef","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-24T09:37:30.692048Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ef5ef2a9544a39ef","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-24T09:37:30.693959Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-24T09:37:30.694118Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-24T09:37:30.694143Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-24T09:37:30.694683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ef5ef2a9544a39ef switched to configuration voters=(17248490431953123823)"} {"level":"info","ts":"2026-06-24T09:37:30.69498Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"58d35553a3d286c0","local-member-id":"ef5ef2a9544a39ef","added-peer-id":"ef5ef2a9544a39ef","added-peer-peer-urls":["https://199.19.213.57:2380"]} {"level":"info","ts":"2026-06-24T09:37:30.696488Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-24T09:37:30.696577Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.57:2380"} {"level":"info","ts":"2026-06-24T09:37:30.696609Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.57:2380"} {"level":"info","ts":"2026-06-24T09:37:30.696779Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ef5ef2a9544a39ef","initial-advertise-peer-urls":["https://199.19.213.57:2380"],"listen-peer-urls":["https://199.19.213.57:2380"],"advertise-client-urls":["https://199.19.213.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-24T09:37:30.696815Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-24T09:37:30.781061Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ef5ef2a9544a39ef is starting a new election at term 1"} {"level":"info","ts":"2026-06-24T09:37:30.78112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ef5ef2a9544a39ef became pre-candidate at term 1"} {"level":"info","ts":"2026-06-24T09:37:30.781162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ef5ef2a9544a39ef received MsgPreVoteResp from ef5ef2a9544a39ef at term 1"} {"level":"info","ts":"2026-06-24T09:37:30.781181Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ef5ef2a9544a39ef became candidate at term 2"} {"level":"info","ts":"2026-06-24T09:37:30.781201Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ef5ef2a9544a39ef received MsgVoteResp from ef5ef2a9544a39ef at term 2"} {"level":"info","ts":"2026-06-24T09:37:30.78122Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ef5ef2a9544a39ef became leader at term 2"} {"level":"info","ts":"2026-06-24T09:37:30.781234Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ef5ef2a9544a39ef elected leader ef5ef2a9544a39ef at term 2"} {"level":"info","ts":"2026-06-24T09:37:30.78214Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T09:37:30.782855Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ef5ef2a9544a39ef","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.57:2379]}","request-path":"/0/members/ef5ef2a9544a39ef/attributes","cluster-id":"58d35553a3d286c0","publish-timeout":"7s"} {"level":"info","ts":"2026-06-24T09:37:30.783048Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T09:37:30.783116Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T09:37:30.783185Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-24T09:37:30.783227Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-24T09:37:30.783646Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"58d35553a3d286c0","local-member-id":"ef5ef2a9544a39ef","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T09:37:30.783777Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T09:37:30.783814Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T09:37:30.786104Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.57:2379"} {"level":"info","ts":"2026-06-24T09:37:30.786378Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-24T09:37:36.507292Z","caller":"traceutil/trace.go:171","msg":"trace[462265154] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"149.727691ms","start":"2026-06-24T09:37:36.357541Z","end":"2026-06-24T09:37:36.507268Z","steps":["trace[462265154] 'process raft request' (duration: 116.53465ms)","trace[462265154] 'compare' (duration: 32.997839ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T09:37:36.507411Z","caller":"traceutil/trace.go:171","msg":"trace[774243248] transaction","detail":"{read_only:false; response_revision:274; number_of_response:1; }","duration":"120.627864ms","start":"2026-06-24T09:37:36.386757Z","end":"2026-06-24T09:37:36.507385Z","steps":["trace[774243248] 'process raft request' (duration: 120.461412ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:37:36.818035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.284869ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T09:37:36.818233Z","caller":"traceutil/trace.go:171","msg":"trace[576621045] transaction","detail":"{read_only:false; response_revision:276; number_of_response:1; }","duration":"279.828232ms","start":"2026-06-24T09:37:36.538389Z","end":"2026-06-24T09:37:36.818218Z","steps":["trace[576621045] 'process raft request' (duration: 279.771721ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:37:36.818429Z","caller":"traceutil/trace.go:171","msg":"trace[4827889] transaction","detail":"{read_only:false; response_revision:275; number_of_response:1; }","duration":"300.757031ms","start":"2026-06-24T09:37:36.517662Z","end":"2026-06-24T09:37:36.818419Z","steps":["trace[4827889] 'process raft request' (duration: 130.485834ms)","trace[4827889] 'compare' (duration: 169.199099ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T09:37:36.818492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:37:36.517642Z","time spent":"300.816101ms","remote":"127.0.0.1:43326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4307,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T09:37:37.426339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.285607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-24T09:37:37.426416Z","caller":"traceutil/trace.go:171","msg":"trace[2136383946] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:280; }","duration":"218.439739ms","start":"2026-06-24T09:37:37.207957Z","end":"2026-06-24T09:37:37.426397Z","steps":["trace[2136383946] 'range keys from in-memory index tree' (duration: 218.178327ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:37:37.426577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.886444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-24T09:37:37.426671Z","caller":"traceutil/trace.go:171","msg":"trace[1565430170] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:280; }","duration":"488.020355ms","start":"2026-06-24T09:37:36.938628Z","end":"2026-06-24T09:37:37.426648Z","steps":["trace[1565430170] 'range keys from in-memory index tree' (duration: 487.781043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:37:37.426725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:37:36.938607Z","time spent":"488.106746ms","remote":"127.0.0.1:43274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-06-24T09:37:37.804006Z","caller":"traceutil/trace.go:171","msg":"trace[2022799896] transaction","detail":"{read_only:false; response_revision:281; number_of_response:1; }","duration":"374.663254ms","start":"2026-06-24T09:37:37.429325Z","end":"2026-06-24T09:37:37.803988Z","steps":["trace[2022799896] 'process raft request' (duration: 374.554993ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:37:37.804127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:37:37.429306Z","time spent":"374.762224ms","remote":"127.0.0.1:43338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":217,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T09:37:38.370447Z","caller":"traceutil/trace.go:171","msg":"trace[1838753605] linearizableReadLoop","detail":"{readStateIndex:295; appliedIndex:293; }","duration":"843.073887ms","start":"2026-06-24T09:37:37.527349Z","end":"2026-06-24T09:37:38.370422Z","steps":["trace[1838753605] 'read index received' (duration: 276.54166ms)","trace[1838753605] 'applied index is now lower than readState.Index' (duration: 566.531177ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T09:37:38.370633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"843.260909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-24T09:37:38.370629Z","caller":"traceutil/trace.go:171","msg":"trace[1937635928] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"940.230923ms","start":"2026-06-24T09:37:37.430363Z","end":"2026-06-24T09:37:38.370594Z","steps":["trace[1937635928] 'process raft request' (duration: 910.03523ms)","trace[1937635928] 'compare' (duration: 29.9071ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T09:37:38.370715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.12702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T09:37:38.37074Z","caller":"traceutil/trace.go:171","msg":"trace[1570707725] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:0; response_revision:282; }","duration":"563.194991ms","start":"2026-06-24T09:37:37.807539Z","end":"2026-06-24T09:37:38.370734Z","steps":["trace[1570707725] 'agreement among raft nodes before linearized reading' (duration: 563.15174ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:37:38.370774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:37:37.807521Z","time spent":"563.245221ms","remote":"127.0.0.1:43338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"warn","ts":"2026-06-24T09:37:38.370793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:37:37.430346Z","time spent":"940.358583ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T09:37:38.370665Z","caller":"traceutil/trace.go:171","msg":"trace[735510357] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:282; }","duration":"843.338569ms","start":"2026-06-24T09:37:37.527317Z","end":"2026-06-24T09:37:38.370656Z","steps":["trace[735510357] 'agreement among raft nodes before linearized reading' (duration: 843.232758ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:37:38.371222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:37:37.527299Z","time spent":"843.884944ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-24T09:37:38.666288Z","caller":"traceutil/trace.go:171","msg":"trace[1684498088] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"291.353803ms","start":"2026-06-24T09:37:38.374901Z","end":"2026-06-24T09:37:38.666255Z","steps":["trace[1684498088] 'process raft request' (duration: 265.957069ms)","trace[1684498088] 'compare' (duration: 25.262493ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T09:37:38.666487Z","caller":"traceutil/trace.go:171","msg":"trace[1044468944] transaction","detail":"{read_only:false; response_revision:285; number_of_response:1; }","duration":"289.586719ms","start":"2026-06-24T09:37:38.376889Z","end":"2026-06-24T09:37:38.666476Z","steps":["trace[1044468944] 'process raft request' (duration: 289.538978ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:37:38.666501Z","caller":"traceutil/trace.go:171","msg":"trace[1066992352] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"291.637046ms","start":"2026-06-24T09:37:38.374855Z","end":"2026-06-24T09:37:38.666492Z","steps":["trace[1066992352] 'process raft request' (duration: 291.359234ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:08.706207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.46589ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:10089"} {"level":"info","ts":"2026-06-24T09:38:08.70644Z","caller":"traceutil/trace.go:171","msg":"trace[486613246] transaction","detail":"{read_only:false; number_of_response:1; response_revision:494; }","duration":"635.416954ms","start":"2026-06-24T09:38:08.070995Z","end":"2026-06-24T09:38:08.706412Z","steps":["trace[486613246] 'process raft request' (duration: 289.647779ms)","trace[486613246] 'compare' (duration: 345.372256ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T09:38:08.706521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:08.07098Z","time spent":"635.506658ms","remote":"127.0.0.1:43198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":101,"response count":0,"response size":10112,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T09:38:08.706907Z","caller":"traceutil/trace.go:171","msg":"trace[282189828] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"635.789582ms","start":"2026-06-24T09:38:08.071081Z","end":"2026-06-24T09:38:08.70687Z","steps":["trace[282189828] 'process raft request' (duration: 635.256476ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:08.707002Z","caller":"traceutil/trace.go:171","msg":"trace[578809051] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"629.767922ms","start":"2026-06-24T09:38:08.077225Z","end":"2026-06-24T09:38:08.706993Z","steps":["trace[578809051] 'process raft request' (duration: 629.642266ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:08.707068Z","caller":"traceutil/trace.go:171","msg":"trace[647574559] transaction","detail":"{read_only:false; number_of_response:0; response_revision:497; }","duration":"630.16541ms","start":"2026-06-24T09:38:08.076893Z","end":"2026-06-24T09:38:08.707058Z","steps":["trace[647574559] 'process raft request' (duration: 629.945508ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:08.706948Z","caller":"traceutil/trace.go:171","msg":"trace[1269500831] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"630.125698ms","start":"2026-06-24T09:38:08.076807Z","end":"2026-06-24T09:38:08.706932Z","steps":["trace[1269500831] 'process raft request' (duration: 630.007101ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:08.707108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:08.077217Z","time spent":"629.816153ms","remote":"127.0.0.1:43198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T09:38:08.707126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:08.076794Z","time spent":"630.313147ms","remote":"127.0.0.1:43626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T09:38:08.707126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:08.076876Z","time spent":"630.222852ms","remote":"127.0.0.1:43626","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T09:38:08.707217Z","caller":"traceutil/trace.go:171","msg":"trace[845066491] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"610.748384ms","start":"2026-06-24T09:38:08.096459Z","end":"2026-06-24T09:38:08.707208Z","steps":["trace[845066491] 'process raft request' (duration: 610.525944ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:08.706908Z","caller":"traceutil/trace.go:171","msg":"trace[1927888091] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"630.101176ms","start":"2026-06-24T09:38:08.076761Z","end":"2026-06-24T09:38:08.706862Z","steps":["trace[1927888091] 'process raft request' (duration: 630.005141ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:08.707252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:08.096451Z","time spent":"610.782397ms","remote":"127.0.0.1:43198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T09:38:08.707065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:08.071074Z","time spent":"635.921019ms","remote":"127.0.0.1:43198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T09:38:08.707282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:08.076753Z","time spent":"630.493685ms","remote":"127.0.0.1:43198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7326,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T09:38:08.707369Z","caller":"traceutil/trace.go:171","msg":"trace[2048547377] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"628.180089ms","start":"2026-06-24T09:38:08.079181Z","end":"2026-06-24T09:38:08.707361Z","steps":["trace[2048547377] 'process raft request' (duration: 627.746849ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:08.707369Z","caller":"traceutil/trace.go:171","msg":"trace[1563089991] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"602.236028ms","start":"2026-06-24T09:38:08.105123Z","end":"2026-06-24T09:38:08.707359Z","steps":["trace[1563089991] 'process raft request' (duration: 601.948235ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:08.707406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:08.079174Z","time spent":"628.21347ms","remote":"127.0.0.1:43198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T09:38:08.707423Z","caller":"traceutil/trace.go:171","msg":"trace[652049552] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"595.903313ms","start":"2026-06-24T09:38:08.111508Z","end":"2026-06-24T09:38:08.707411Z","steps":["trace[652049552] 'process raft request' (duration: 595.599439ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:08.707467Z","caller":"traceutil/trace.go:171","msg":"trace[287090039] transaction","detail":"{read_only:false; number_of_response:1; response_revision:499; }","duration":"617.50378ms","start":"2026-06-24T09:38:08.089957Z","end":"2026-06-24T09:38:08.70746Z","steps":["trace[287090039] 'process raft request' (duration: 616.996347ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:08.707471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:08.105091Z","time spent":"602.300101ms","remote":"127.0.0.1:43198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T09:38:08.707487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:08.111491Z","time spent":"595.966586ms","remote":"127.0.0.1:43198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T09:38:08.707503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:08.089945Z","time spent":"617.536472ms","remote":"127.0.0.1:43198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7375,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T09:38:08.707531Z","caller":"traceutil/trace.go:171","msg":"trace[68320745] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"469.719752ms","start":"2026-06-24T09:38:08.2378Z","end":"2026-06-24T09:38:08.70752Z","steps":["trace[68320745] 'process raft request' (duration: 469.398347ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:08.707546Z","caller":"traceutil/trace.go:171","msg":"trace[1328012115] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"604.427391ms","start":"2026-06-24T09:38:08.10311Z","end":"2026-06-24T09:38:08.707537Z","steps":["trace[1328012115] 'process raft request' (duration: 603.924157ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:08.707584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:08.103094Z","time spent":"604.472483ms","remote":"127.0.0.1:43198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T09:38:08.707587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:08.237765Z","time spent":"469.795106ms","remote":"127.0.0.1:43198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T09:38:09.43298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.865861ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T09:38:09.43336Z","caller":"traceutil/trace.go:171","msg":"trace[1277114259] linearizableReadLoop","detail":"{readStateIndex:559; appliedIndex:558; }","duration":"329.886084ms","start":"2026-06-24T09:38:09.103448Z","end":"2026-06-24T09:38:09.433334Z","steps":["trace[1277114259] 'read index received' (duration: 95.628264ms)","trace[1277114259] 'applied index is now lower than readState.Index' (duration: 234.25598ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T09:38:09.433393Z","caller":"traceutil/trace.go:171","msg":"trace[1376493828] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"318.904658ms","start":"2026-06-24T09:38:09.114469Z","end":"2026-06-24T09:38:09.433374Z","steps":["trace[1376493828] 'process raft request' (duration: 318.840695ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:09.433406Z","caller":"traceutil/trace.go:171","msg":"trace[289061410] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"333.30748ms","start":"2026-06-24T09:38:09.100064Z","end":"2026-06-24T09:38:09.433371Z","steps":["trace[289061410] 'process raft request' (duration: 98.989408ms)","trace[289061410] 'compare' (duration: 233.589769ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T09:38:09.43348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:09.114461Z","time spent":"318.973791ms","remote":"127.0.0.1:43198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T09:38:09.433589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.123734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-24T09:38:09.433624Z","caller":"traceutil/trace.go:171","msg":"trace[130630274] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:534; }","duration":"330.199549ms","start":"2026-06-24T09:38:09.103413Z","end":"2026-06-24T09:38:09.433613Z","steps":["trace[130630274] 'agreement among raft nodes before linearized reading' (duration: 330.034181ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:09.4336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:09.100044Z","time spent":"333.466828ms","remote":"127.0.0.1:43198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":73770,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T09:38:09.433655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:09.103399Z","time spent":"330.25011ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-24T09:38:09.43379Z","caller":"traceutil/trace.go:171","msg":"trace[1552135365] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"319.682553ms","start":"2026-06-24T09:38:09.114058Z","end":"2026-06-24T09:38:09.433741Z","steps":["trace[1552135365] 'process raft request' (duration: 319.099937ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:09.433924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:09.114035Z","time spent":"319.818619ms","remote":"127.0.0.1:43198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80679,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T09:38:09.587495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.485557ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-24T09:38:09.588011Z","caller":"traceutil/trace.go:171","msg":"trace[1717132083] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"134.996058ms","start":"2026-06-24T09:38:09.452985Z","end":"2026-06-24T09:38:09.587981Z","steps":["trace[1717132083] 'process raft request' (duration: 134.675433ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:09.588069Z","caller":"traceutil/trace.go:171","msg":"trace[415975738] linearizableReadLoop","detail":"{readStateIndex:562; appliedIndex:561; }","duration":"154.412001ms","start":"2026-06-24T09:38:09.433422Z","end":"2026-06-24T09:38:09.587834Z","steps":["trace[415975738] 'read index received' (duration: 30.516245ms)","trace[415975738] 'applied index is now lower than readState.Index' (duration: 123.889506ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T09:38:09.588432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.098715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T09:38:09.588449Z","caller":"traceutil/trace.go:171","msg":"trace[39687548] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"133.281758ms","start":"2026-06-24T09:38:09.455156Z","end":"2026-06-24T09:38:09.588438Z","steps":["trace[39687548] 'process raft request' (duration: 132.67324ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:09.588477Z","caller":"traceutil/trace.go:171","msg":"trace[1348765247] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:536; }","duration":"213.201639ms","start":"2026-06-24T09:38:09.375262Z","end":"2026-06-24T09:38:09.588464Z","steps":["trace[1348765247] 'agreement among raft nodes before linearized reading' (duration: 212.635293ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:09.588615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.623327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T09:38:09.5887Z","caller":"traceutil/trace.go:171","msg":"trace[1103034744] 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:536; }","duration":"178.70159ms","start":"2026-06-24T09:38:09.409948Z","end":"2026-06-24T09:38:09.588649Z","steps":["trace[1103034744] 'agreement among raft nodes before linearized reading' (duration: 177.974047ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:09.588888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.211311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T09:38:09.588939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.885591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T09:38:09.58896Z","caller":"traceutil/trace.go:171","msg":"trace[908614140] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:536; }","duration":"233.325336ms","start":"2026-06-24T09:38:09.355618Z","end":"2026-06-24T09:38:09.588943Z","steps":["trace[908614140] 'agreement among raft nodes before linearized reading' (duration: 232.362172ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:09.588983Z","caller":"traceutil/trace.go:171","msg":"trace[1046645583] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:536; }","duration":"213.954714ms","start":"2026-06-24T09:38:09.375012Z","end":"2026-06-24T09:38:09.588967Z","steps":["trace[1046645583] 'agreement among raft nodes before linearized reading' (duration: 213.00155ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:09.588992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.206337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T09:38:09.588975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.371417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T09:38:09.589042Z","caller":"traceutil/trace.go:171","msg":"trace[355119003] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:536; }","duration":"259.283661ms","start":"2026-06-24T09:38:09.329743Z","end":"2026-06-24T09:38:09.589026Z","steps":["trace[355119003] 'agreement among raft nodes before linearized reading' (duration: 258.267544ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:09.589095Z","caller":"traceutil/trace.go:171","msg":"trace[1901760922] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:536; }","duration":"294.532575ms","start":"2026-06-24T09:38:09.294528Z","end":"2026-06-24T09:38:09.589061Z","steps":["trace[1901760922] 'agreement among raft nodes before linearized reading' (duration: 293.500768ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:09.589263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.868087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T09:38:09.589299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.518425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T09:38:09.589313Z","caller":"traceutil/trace.go:171","msg":"trace[722277427] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:536; }","duration":"201.949091ms","start":"2026-06-24T09:38:09.387352Z","end":"2026-06-24T09:38:09.589301Z","steps":["trace[722277427] 'agreement among raft nodes before linearized reading' (duration: 200.578299ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:09.589324Z","caller":"traceutil/trace.go:171","msg":"trace[215077234] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:536; }","duration":"233.549527ms","start":"2026-06-24T09:38:09.355766Z","end":"2026-06-24T09:38:09.589316Z","steps":["trace[215077234] 'agreement among raft nodes before linearized reading' (duration: 232.254457ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:09.589336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.818289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T09:38:09.58938Z","caller":"traceutil/trace.go:171","msg":"trace[2127821702] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:536; }","duration":"294.891182ms","start":"2026-06-24T09:38:09.294478Z","end":"2026-06-24T09:38:09.58937Z","steps":["trace[2127821702] 'agreement among raft nodes before linearized reading' (duration: 293.632664ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:09.589463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.693954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T09:38:09.589493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.582141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T09:38:09.589526Z","caller":"traceutil/trace.go:171","msg":"trace[639672535] 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:536; }","duration":"179.642385ms","start":"2026-06-24T09:38:09.409875Z","end":"2026-06-24T09:38:09.589518Z","steps":["trace[639672535] 'agreement among raft nodes before linearized reading' (duration: 178.088253ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:09.589557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.409783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T09:38:09.589593Z","caller":"traceutil/trace.go:171","msg":"trace[745482163] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:536; }","duration":"202.541329ms","start":"2026-06-24T09:38:09.387043Z","end":"2026-06-24T09:38:09.589585Z","steps":["trace[745482163] 'agreement among raft nodes before linearized reading' (duration: 200.887973ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:09.589732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.915491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T09:38:09.589766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.808331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T09:38:09.589765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.794352ms","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-06-24T09:38:09.589796Z","caller":"traceutil/trace.go:171","msg":"trace[72443089] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:536; }","duration":"202.867203ms","start":"2026-06-24T09:38:09.386921Z","end":"2026-06-24T09:38:09.589788Z","steps":["trace[72443089] 'agreement among raft nodes before linearized reading' (duration: 201.032259ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:09.589805Z","caller":"traceutil/trace.go:171","msg":"trace[140317568] 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:536; }","duration":"179.848924ms","start":"2026-06-24T09:38:09.409945Z","end":"2026-06-24T09:38:09.589794Z","steps":["trace[140317568] 'agreement among raft nodes before linearized reading' (duration: 178.005788ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:09.589813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.852938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T09:38:09.58985Z","caller":"traceutil/trace.go:171","msg":"trace[1573437148] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:536; }","duration":"259.947673ms","start":"2026-06-24T09:38:09.329892Z","end":"2026-06-24T09:38:09.58984Z","steps":["trace[1573437148] 'agreement among raft nodes before linearized reading' (duration: 258.100997ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:09.589769Z","caller":"traceutil/trace.go:171","msg":"trace[594578294] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:536; }","duration":"259.951283ms","start":"2026-06-24T09:38:09.329805Z","end":"2026-06-24T09:38:09.589757Z","steps":["trace[594578294] 'agreement among raft nodes before linearized reading' (duration: 258.169121ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:09.589501Z","caller":"traceutil/trace.go:171","msg":"trace[826634224] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:536; }","duration":"233.744366ms","start":"2026-06-24T09:38:09.355747Z","end":"2026-06-24T09:38:09.589492Z","steps":["trace[826634224] 'agreement among raft nodes before linearized reading' (duration: 232.275168ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:09.590197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.338459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T09:38:09.590203Z","caller":"traceutil/trace.go:171","msg":"trace[1624588657] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"132.186218ms","start":"2026-06-24T09:38:09.458005Z","end":"2026-06-24T09:38:09.590191Z","steps":["trace[1624588657] 'process raft request' (duration: 130.373984ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:09.590251Z","caller":"traceutil/trace.go:171","msg":"trace[1391551928] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:537; }","duration":"212.407033ms","start":"2026-06-24T09:38:09.37783Z","end":"2026-06-24T09:38:09.590237Z","steps":["trace[1391551928] 'agreement among raft nodes before linearized reading' (duration: 210.131238ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:09.590321Z","caller":"traceutil/trace.go:171","msg":"trace[554494446] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"131.914585ms","start":"2026-06-24T09:38:09.458398Z","end":"2026-06-24T09:38:09.590312Z","steps":["trace[554494446] 'process raft request' (duration: 131.676974ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:10.679465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.850995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:18056"} {"level":"info","ts":"2026-06-24T09:38:10.679526Z","caller":"traceutil/trace.go:171","msg":"trace[73431672] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:560; }","duration":"110.951081ms","start":"2026-06-24T09:38:10.56856Z","end":"2026-06-24T09:38:10.679512Z","steps":["trace[73431672] 'range keys from in-memory index tree' (duration: 110.738691ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:13.718477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.769325ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T09:38:13.718585Z","caller":"traceutil/trace.go:171","msg":"trace[948600068] linearizableReadLoop","detail":"{readStateIndex:605; appliedIndex:604; }","duration":"107.89117ms","start":"2026-06-24T09:38:13.610678Z","end":"2026-06-24T09:38:13.718569Z","steps":["trace[948600068] 'read index received' (duration: 4.918486ms)","trace[948600068] 'applied index is now lower than readState.Index' (duration: 102.971324ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T09:38:13.718678Z","caller":"traceutil/trace.go:171","msg":"trace[820492633] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"116.375253ms","start":"2026-06-24T09:38:13.602271Z","end":"2026-06-24T09:38:13.718647Z","steps":["trace[820492633] 'process raft request' (duration: 13.373797ms)","trace[820492633] 'compare' (duration: 102.603168ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T09:38:13.71878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.103081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-24T09:38:13.718813Z","caller":"traceutil/trace.go:171","msg":"trace[182394374] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:577; }","duration":"108.180063ms","start":"2026-06-24T09:38:13.610623Z","end":"2026-06-24T09:38:13.718804Z","steps":["trace[182394374] 'agreement among raft nodes before linearized reading' (duration: 108.001706ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:15.198531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.733039ms","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-06-24T09:38:15.198613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.129009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-24T09:38:15.198645Z","caller":"traceutil/trace.go:171","msg":"trace[565319381] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:587; }","duration":"299.895035ms","start":"2026-06-24T09:38:14.898727Z","end":"2026-06-24T09:38:15.198622Z","steps":["trace[565319381] 'range keys from in-memory index tree' (duration: 299.519669ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:15.198695Z","caller":"traceutil/trace.go:171","msg":"trace[11386006] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:587; }","duration":"275.271326ms","start":"2026-06-24T09:38:14.923402Z","end":"2026-06-24T09:38:15.198673Z","steps":["trace[11386006] 'range keys from in-memory index tree' (duration: 274.942851ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:15.198726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:14.898702Z","time spent":"300.00853ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-24T09:38:15.708638Z","caller":"traceutil/trace.go:171","msg":"trace[2049392822] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"566.49646ms","start":"2026-06-24T09:38:15.142115Z","end":"2026-06-24T09:38:15.708611Z","steps":["trace[2049392822] 'process raft request' (duration: 560.101245ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:15.708783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:15.142083Z","time spent":"566.626855ms","remote":"127.0.0.1:43246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T09:38:15.723942Z","caller":"traceutil/trace.go:171","msg":"trace[986792430] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"520.985415ms","start":"2026-06-24T09:38:15.202935Z","end":"2026-06-24T09:38:15.723921Z","steps":["trace[986792430] 'process raft request' (duration: 520.548626ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:15.724081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:15.202905Z","time spent":"521.107521ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T09:38:15.724338Z","caller":"traceutil/trace.go:171","msg":"trace[1028566823] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"520.88406ms","start":"2026-06-24T09:38:15.203411Z","end":"2026-06-24T09:38:15.724295Z","steps":["trace[1028566823] 'process raft request' (duration: 520.203831ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:15.724485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:15.203384Z","time spent":"521.024176ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T09:38:15.72449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.223448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-j2d58\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-24T09:38:15.724522Z","caller":"traceutil/trace.go:171","msg":"trace[1347333364] range","detail":"{range_begin:/registry/pods/kube-system/cilium-j2d58; range_end:; response_count:1; response_revision:590; }","duration":"358.292151ms","start":"2026-06-24T09:38:15.366221Z","end":"2026-06-24T09:38:15.724513Z","steps":["trace[1347333364] 'agreement among raft nodes before linearized reading' (duration: 358.184866ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:15.724548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:15.366201Z","time spent":"358.342644ms","remote":"127.0.0.1:43326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-j2d58\" "} {"level":"info","ts":"2026-06-24T09:38:15.72438Z","caller":"traceutil/trace.go:171","msg":"trace[737216937] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:616; }","duration":"357.532328ms","start":"2026-06-24T09:38:15.36627Z","end":"2026-06-24T09:38:15.723802Z","steps":["trace[737216937] 'read index received' (duration: 335.731262ms)","trace[737216937] 'applied index is now lower than readState.Index' (duration: 21.800106ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T09:38:16.10689Z","caller":"traceutil/trace.go:171","msg":"trace[169875272] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"361.857572ms","start":"2026-06-24T09:38:15.744991Z","end":"2026-06-24T09:38:16.106848Z","steps":["trace[169875272] 'process raft request' (duration: 361.58767ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:16.107062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.099285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-24T09:38:16.107144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:15.74497Z","time spent":"362.05505ms","remote":"127.0.0.1:43326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T09:38:16.107184Z","caller":"traceutil/trace.go:171","msg":"trace[1039396142] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:591; }","duration":"346.254701ms","start":"2026-06-24T09:38:15.760906Z","end":"2026-06-24T09:38:16.107161Z","steps":["trace[1039396142] 'agreement among raft nodes before linearized reading' (duration: 346.013521ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:16.107362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:15.760888Z","time spent":"346.425078ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-24T09:38:16.106796Z","caller":"traceutil/trace.go:171","msg":"trace[1727753976] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"345.828363ms","start":"2026-06-24T09:38:15.760938Z","end":"2026-06-24T09:38:16.106766Z","steps":["trace[1727753976] 'read index received' (duration: 345.652036ms)","trace[1727753976] 'applied index is now lower than readState.Index' (duration: 174.967µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T09:38:16.176206Z","caller":"traceutil/trace.go:171","msg":"trace[562656939] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"408.484159ms","start":"2026-06-24T09:38:15.767699Z","end":"2026-06-24T09:38:16.176183Z","steps":["trace[562656939] 'process raft request' (duration: 408.235529ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:16.176202Z","caller":"traceutil/trace.go:171","msg":"trace[2139821479] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"211.939112ms","start":"2026-06-24T09:38:15.964232Z","end":"2026-06-24T09:38:16.176172Z","steps":["trace[2139821479] 'process raft request' (duration: 211.852138ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:16.176319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:15.767683Z","time spent":"408.585154ms","remote":"127.0.0.1:43492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T09:38:17.224693Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4174730171844803869,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T09:38:17.725872Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4174730171844803869,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T09:38:17.960611Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.377808663s","expected-duration":"1s"} {"level":"info","ts":"2026-06-24T09:38:17.962136Z","caller":"traceutil/trace.go:171","msg":"trace[1309823412] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:623; }","duration":"1.238318312s","start":"2026-06-24T09:38:16.723779Z","end":"2026-06-24T09:38:17.962097Z","steps":["trace[1309823412] 'read index received' (duration: 1.237013138s)","trace[1309823412] 'applied index is now lower than readState.Index' (duration: 1.303544ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T09:38:17.962214Z","caller":"traceutil/trace.go:171","msg":"trace[959447675] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"1.380404651s","start":"2026-06-24T09:38:16.58177Z","end":"2026-06-24T09:38:17.962174Z","steps":["trace[959447675] 'process raft request' (duration: 1.379526345s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:17.962394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:16.581738Z","time spent":"1.380542507s","remote":"127.0.0.1:43246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T09:38:17.962427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.238582794s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T09:38:17.962493Z","caller":"traceutil/trace.go:171","msg":"trace[1911316671] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:595; }","duration":"1.23873644s","start":"2026-06-24T09:38:16.723737Z","end":"2026-06-24T09:38:17.962474Z","steps":["trace[1911316671] 'agreement among raft nodes before linearized reading' (duration: 1.238576773s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:17.962562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:16.723715Z","time spent":"1.238829144s","remote":"127.0.0.1:43160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T09:38:17.96275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.200884162s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-24T09:38:17.962814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.967634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-24T09:38:17.962868Z","caller":"traceutil/trace.go:171","msg":"trace[594073363] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:595; }","duration":"233.040967ms","start":"2026-06-24T09:38:17.729812Z","end":"2026-06-24T09:38:17.962853Z","steps":["trace[594073363] 'agreement among raft nodes before linearized reading' (duration: 232.918371ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:17.962844Z","caller":"traceutil/trace.go:171","msg":"trace[630242227] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:595; }","duration":"1.20103246s","start":"2026-06-24T09:38:16.761792Z","end":"2026-06-24T09:38:17.962824Z","steps":["trace[630242227] 'agreement among raft nodes before linearized reading' (duration: 1.200635503s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:17.962955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.723346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-24T09:38:17.963007Z","caller":"traceutil/trace.go:171","msg":"trace[1630319644] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:595; }","duration":"233.81701ms","start":"2026-06-24T09:38:17.729161Z","end":"2026-06-24T09:38:17.962978Z","steps":["trace[1630319644] 'agreement among raft nodes before linearized reading' (duration: 233.734316ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:17.963005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:16.761773Z","time spent":"1.201209068s","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T09:38:18.257429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.4645ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T09:38:18.257742Z","caller":"traceutil/trace.go:171","msg":"trace[265004483] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"286.475516ms","start":"2026-06-24T09:38:17.971244Z","end":"2026-06-24T09:38:18.25772Z","steps":["trace[265004483] 'process raft request' (duration: 61.524566ms)","trace[265004483] 'compare' (duration: 224.21384ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T09:38:18.258042Z","caller":"traceutil/trace.go:171","msg":"trace[416403344] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"286.757868ms","start":"2026-06-24T09:38:17.971257Z","end":"2026-06-24T09:38:18.258015Z","steps":["trace[416403344] 'process raft request' (duration: 286.391623ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:18.258226Z","caller":"traceutil/trace.go:171","msg":"trace[161968879] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"286.852852ms","start":"2026-06-24T09:38:17.971345Z","end":"2026-06-24T09:38:18.258198Z","steps":["trace[161968879] 'process raft request' (duration: 286.57237ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:18.258345Z","caller":"traceutil/trace.go:171","msg":"trace[980402238] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"240.8902ms","start":"2026-06-24T09:38:18.017439Z","end":"2026-06-24T09:38:18.258329Z","steps":["trace[980402238] 'process raft request' (duration: 240.581748ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:20.048603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.180731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T09:38:20.048712Z","caller":"traceutil/trace.go:171","msg":"trace[428087225] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"323.341077ms","start":"2026-06-24T09:38:19.725354Z","end":"2026-06-24T09:38:20.048695Z","steps":["trace[428087225] 'range keys from in-memory index tree' (duration: 323.077367ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:20.048753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:19.725332Z","time spent":"323.41167ms","remote":"127.0.0.1:43160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T09:38:20.777599Z","caller":"traceutil/trace.go:171","msg":"trace[826782394] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"311.386903ms","start":"2026-06-24T09:38:20.466179Z","end":"2026-06-24T09:38:20.777566Z","steps":["trace[826782394] 'process raft request' (duration: 299.423289ms)","trace[826782394] 'compare' (duration: 11.699154ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T09:38:20.777644Z","caller":"traceutil/trace.go:171","msg":"trace[580532582] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:658; }","duration":"234.928064ms","start":"2026-06-24T09:38:20.542679Z","end":"2026-06-24T09:38:20.777607Z","steps":["trace[580532582] 'read index received' (duration: 222.955739ms)","trace[580532582] 'applied index is now lower than readState.Index' (duration: 11.971045ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T09:38:20.777679Z","caller":"traceutil/trace.go:171","msg":"trace[828742354] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"310.910784ms","start":"2026-06-24T09:38:20.466723Z","end":"2026-06-24T09:38:20.777634Z","steps":["trace[828742354] 'process raft request' (duration: 310.836241ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:20.777797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:20.466167Z","time spent":"311.518638ms","remote":"127.0.0.1:43228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":700,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T09:38:20.777822Z","caller":"traceutil/trace.go:171","msg":"trace[291034457] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"311.497338ms","start":"2026-06-24T09:38:20.466308Z","end":"2026-06-24T09:38:20.777805Z","steps":["trace[291034457] 'process raft request' (duration: 311.185575ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:20.777866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:20.466704Z","time spent":"311.089551ms","remote":"127.0.0.1:43198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T09:38:20.777967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.948812ms","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-06-24T09:38:20.778013Z","caller":"traceutil/trace.go:171","msg":"trace[1320440034] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:631; }","duration":"120.046216ms","start":"2026-06-24T09:38:20.657955Z","end":"2026-06-24T09:38:20.778001Z","steps":["trace[1320440034] 'agreement among raft nodes before linearized reading' (duration: 119.966283ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:20.777931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.709667ms","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":"warn","ts":"2026-06-24T09:38:20.777882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:20.466303Z","time spent":"311.54883ms","remote":"127.0.0.1:43198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T09:38:20.778108Z","caller":"traceutil/trace.go:171","msg":"trace[374130629] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:631; }","duration":"312.909304ms","start":"2026-06-24T09:38:20.465178Z","end":"2026-06-24T09:38:20.778088Z","steps":["trace[374130629] 'agreement among raft nodes before linearized reading' (duration: 312.662804ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:20.778162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:20.465175Z","time spent":"312.972047ms","remote":"127.0.0.1:43198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "} {"level":"warn","ts":"2026-06-24T09:38:20.778262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.119044ms","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-06-24T09:38:20.778353Z","caller":"traceutil/trace.go:171","msg":"trace[1563939812] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:631; }","duration":"313.226078ms","start":"2026-06-24T09:38:20.46511Z","end":"2026-06-24T09:38:20.778336Z","steps":["trace[1563939812] 'agreement among raft nodes before linearized reading' (duration: 313.063291ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:20.778392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:20.465107Z","time spent":"313.27589ms","remote":"127.0.0.1:43198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" "} {"level":"info","ts":"2026-06-24T09:38:21.009538Z","caller":"traceutil/trace.go:171","msg":"trace[2031957484] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"227.01049ms","start":"2026-06-24T09:38:20.782494Z","end":"2026-06-24T09:38:21.009505Z","steps":["trace[2031957484] 'process raft request' (duration: 162.212656ms)","trace[2031957484] 'compare' (duration: 64.573515ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T09:38:21.00955Z","caller":"traceutil/trace.go:171","msg":"trace[231054102] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:662; }","duration":"152.01754ms","start":"2026-06-24T09:38:20.857508Z","end":"2026-06-24T09:38:21.009525Z","steps":["trace[231054102] 'read index received' (duration: 87.100781ms)","trace[231054102] 'applied index is now lower than readState.Index' (duration: 64.915719ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T09:38:21.009685Z","caller":"traceutil/trace.go:171","msg":"trace[1480329776] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"227.139066ms","start":"2026-06-24T09:38:20.782531Z","end":"2026-06-24T09:38:21.00967Z","steps":["trace[1480329776] 'process raft request' (duration: 226.895526ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:21.009694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.167507ms","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-06-24T09:38:21.009673Z","caller":"traceutil/trace.go:171","msg":"trace[2141081629] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"226.351984ms","start":"2026-06-24T09:38:20.783276Z","end":"2026-06-24T09:38:21.009628Z","steps":["trace[2141081629] 'process raft request' (duration: 226.190848ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:21.009733Z","caller":"traceutil/trace.go:171","msg":"trace[484636829] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:635; }","duration":"152.26006ms","start":"2026-06-24T09:38:20.857461Z","end":"2026-06-24T09:38:21.009721Z","steps":["trace[484636829] 'agreement among raft nodes before linearized reading' (duration: 152.178147ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:22.553387Z","caller":"traceutil/trace.go:171","msg":"trace[850937190] linearizableReadLoop","detail":"{readStateIndex:697; appliedIndex:696; }","duration":"140.217857ms","start":"2026-06-24T09:38:22.413146Z","end":"2026-06-24T09:38:22.553364Z","steps":["trace[850937190] 'read index received' (duration: 81.434937ms)","trace[850937190] 'applied index is now lower than readState.Index' (duration: 58.78222ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T09:38:22.553558Z","caller":"traceutil/trace.go:171","msg":"trace[495445931] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"143.913643ms","start":"2026-06-24T09:38:22.409607Z","end":"2026-06-24T09:38:22.553521Z","steps":["trace[495445931] 'process raft request' (duration: 84.898614ms)","trace[495445931] 'compare' (duration: 58.757059ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T09:38:22.55361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.443366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-j2d58\" ","response":"range_response_count:1 size:18063"} {"level":"info","ts":"2026-06-24T09:38:22.553809Z","caller":"traceutil/trace.go:171","msg":"trace[564645726] range","detail":"{range_begin:/registry/pods/kube-system/cilium-j2d58; range_end:; response_count:1; response_revision:667; }","duration":"140.678985ms","start":"2026-06-24T09:38:22.413118Z","end":"2026-06-24T09:38:22.553797Z","steps":["trace[564645726] 'agreement among raft nodes before linearized reading' (duration: 140.366803ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:22.564406Z","caller":"traceutil/trace.go:171","msg":"trace[179805230] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"150.973014ms","start":"2026-06-24T09:38:22.413408Z","end":"2026-06-24T09:38:22.564381Z","steps":["trace[179805230] 'process raft request' (duration: 150.61686ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:22.56444Z","caller":"traceutil/trace.go:171","msg":"trace[2023803310] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"100.730093ms","start":"2026-06-24T09:38:22.463695Z","end":"2026-06-24T09:38:22.564425Z","steps":["trace[2023803310] 'process raft request' (duration: 100.452212ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:24.506608Z","caller":"traceutil/trace.go:171","msg":"trace[1233826087] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"155.406233ms","start":"2026-06-24T09:38:24.351176Z","end":"2026-06-24T09:38:24.506582Z","steps":["trace[1233826087] 'process raft request' (duration: 155.231156ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:24.565381Z","caller":"traceutil/trace.go:171","msg":"trace[1861197937] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"213.343649ms","start":"2026-06-24T09:38:24.352019Z","end":"2026-06-24T09:38:24.565362Z","steps":["trace[1861197937] 'process raft request' (duration: 213.199914ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:24.565541Z","caller":"traceutil/trace.go:171","msg":"trace[1137451646] linearizableReadLoop","detail":"{readStateIndex:721; appliedIndex:718; }","duration":"159.788364ms","start":"2026-06-24T09:38:24.405745Z","end":"2026-06-24T09:38:24.565533Z","steps":["trace[1137451646] 'read index received' (duration: 100.739005ms)","trace[1137451646] 'applied index is now lower than readState.Index' (duration: 59.048589ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T09:38:24.565774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.4999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-j2d58\" ","response":"range_response_count:1 size:18512"} {"level":"warn","ts":"2026-06-24T09:38:24.565776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.022453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-24T09:38:24.565806Z","caller":"traceutil/trace.go:171","msg":"trace[1194402176] range","detail":"{range_begin:/registry/pods/kube-system/cilium-j2d58; range_end:; response_count:1; response_revision:690; }","duration":"129.584903ms","start":"2026-06-24T09:38:24.436213Z","end":"2026-06-24T09:38:24.565798Z","steps":["trace[1194402176] 'agreement among raft nodes before linearized reading' (duration: 129.442136ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:24.565828Z","caller":"traceutil/trace.go:171","msg":"trace[2098178945] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:690; }","duration":"160.124498ms","start":"2026-06-24T09:38:24.405689Z","end":"2026-06-24T09:38:24.565814Z","steps":["trace[2098178945] 'agreement among raft nodes before linearized reading' (duration: 159.914408ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:24.56612Z","caller":"traceutil/trace.go:171","msg":"trace[806302564] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"213.779387ms","start":"2026-06-24T09:38:24.352256Z","end":"2026-06-24T09:38:24.566035Z","steps":["trace[806302564] 'process raft request' (duration: 213.080059ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:24.566354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.577369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-06-24T09:38:24.566485Z","caller":"traceutil/trace.go:171","msg":"trace[1538248986] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:690; }","duration":"108.87328ms","start":"2026-06-24T09:38:24.457591Z","end":"2026-06-24T09:38:24.566464Z","steps":["trace[1538248986] 'agreement among raft nodes before linearized reading' (duration: 108.409423ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:34.616637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"847.630599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.57\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-24T09:38:34.616753Z","caller":"traceutil/trace.go:171","msg":"trace[1452638741] range","detail":"{range_begin:/registry/masterleases/199.19.213.57; range_end:; response_count:1; response_revision:756; }","duration":"847.781394ms","start":"2026-06-24T09:38:33.768952Z","end":"2026-06-24T09:38:34.616733Z","steps":["trace[1452638741] 'range keys from in-memory index tree' (duration: 847.452683ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:34.616796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:33.768934Z","time spent":"847.849247ms","remote":"127.0.0.1:43182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.19.213.57\" "} {"level":"warn","ts":"2026-06-24T09:38:34.616883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.567074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T09:38:34.61695Z","caller":"traceutil/trace.go:171","msg":"trace[195103547] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:756; }","duration":"646.692698ms","start":"2026-06-24T09:38:33.970242Z","end":"2026-06-24T09:38:34.616935Z","steps":["trace[195103547] 'count revisions from in-memory index tree' (duration: 646.486601ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:34.616989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:38:33.970218Z","time spent":"646.758841ms","remote":"127.0.0.1:43322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":30,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"info","ts":"2026-06-24T09:38:34.724591Z","caller":"traceutil/trace.go:171","msg":"trace[1724656707] linearizableReadLoop","detail":"{readStateIndex:790; appliedIndex:789; }","duration":"172.501868ms","start":"2026-06-24T09:38:34.552069Z","end":"2026-06-24T09:38:34.724571Z","steps":["trace[1724656707] 'read index received' (duration: 172.351723ms)","trace[1724656707] 'applied index is now lower than readState.Index' (duration: 149.335µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T09:38:34.72483Z","caller":"traceutil/trace.go:171","msg":"trace[1774911810] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"230.121531ms","start":"2026-06-24T09:38:34.494671Z","end":"2026-06-24T09:38:34.724793Z","steps":["trace[1774911810] 'process raft request' (duration: 229.758228ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:34.724873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.777007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-24T09:38:34.724938Z","caller":"traceutil/trace.go:171","msg":"trace[1054841935] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:757; }","duration":"172.882741ms","start":"2026-06-24T09:38:34.552037Z","end":"2026-06-24T09:38:34.72492Z","steps":["trace[1054841935] 'agreement among raft nodes before linearized reading' (duration: 172.717435ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:34.824212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.516185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-24T09:38:34.824297Z","caller":"traceutil/trace.go:171","msg":"trace[749070242] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:758; }","duration":"207.66746ms","start":"2026-06-24T09:38:34.616606Z","end":"2026-06-24T09:38:34.824274Z","steps":["trace[749070242] 'agreement among raft nodes before linearized reading' (duration: 207.404911ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:34.824778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.16652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-24T09:38:34.824871Z","caller":"traceutil/trace.go:171","msg":"trace[2092505710] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:758; }","duration":"202.266564ms","start":"2026-06-24T09:38:34.622554Z","end":"2026-06-24T09:38:34.82482Z","steps":["trace[2092505710] 'agreement among raft nodes before linearized reading' (duration: 202.079637ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:34.824918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.747734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-24T09:38:34.825009Z","caller":"traceutil/trace.go:171","msg":"trace[1445682544] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:758; }","duration":"165.898569ms","start":"2026-06-24T09:38:34.659093Z","end":"2026-06-24T09:38:34.824992Z","steps":["trace[1445682544] 'agreement among raft nodes before linearized reading' (duration: 164.924604ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:37.01728Z","caller":"traceutil/trace.go:171","msg":"trace[1674765020] linearizableReadLoop","detail":"{readStateIndex:808; appliedIndex:807; }","duration":"159.017879ms","start":"2026-06-24T09:38:36.85824Z","end":"2026-06-24T09:38:37.017258Z","steps":["trace[1674765020] 'read index received' (duration: 24.653659ms)","trace[1674765020] 'applied index is now lower than readState.Index' (duration: 134.36342ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T09:38:37.017369Z","caller":"traceutil/trace.go:171","msg":"trace[1314089118] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"174.962762ms","start":"2026-06-24T09:38:36.842367Z","end":"2026-06-24T09:38:37.01733Z","steps":["trace[1314089118] 'process raft request' (duration: 136.223657ms)","trace[1314089118] 'compare' (duration: 38.534358ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T09:38:37.01751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.243977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-24T09:38:37.017542Z","caller":"traceutil/trace.go:171","msg":"trace[1274673756] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:774; }","duration":"159.33245ms","start":"2026-06-24T09:38:36.858202Z","end":"2026-06-24T09:38:37.017534Z","steps":["trace[1274673756] 'agreement among raft nodes before linearized reading' (duration: 159.185035ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:37.017899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.165903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-24T09:38:37.017926Z","caller":"traceutil/trace.go:171","msg":"trace[1788859645] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:774; }","duration":"159.209234ms","start":"2026-06-24T09:38:36.85871Z","end":"2026-06-24T09:38:37.017919Z","steps":["trace[1788859645] 'agreement among raft nodes before linearized reading' (duration: 159.137592ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:38:37.017973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.587477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-24T09:38:37.018004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.360479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-24T09:38:37.018077Z","caller":"traceutil/trace.go:171","msg":"trace[774023790] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:774; }","duration":"159.475424ms","start":"2026-06-24T09:38:36.858592Z","end":"2026-06-24T09:38:37.018068Z","steps":["trace[774023790] 'agreement among raft nodes before linearized reading' (duration: 159.258526ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:37.018034Z","caller":"traceutil/trace.go:171","msg":"trace[953210702] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:774; }","duration":"159.702684ms","start":"2026-06-24T09:38:36.85832Z","end":"2026-06-24T09:38:37.018023Z","steps":["trace[953210702] 'agreement among raft nodes before linearized reading' (duration: 159.527137ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:46.678092Z","caller":"traceutil/trace.go:171","msg":"trace[1123428861] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"129.13681ms","start":"2026-06-24T09:38:46.548633Z","end":"2026-06-24T09:38:46.67777Z","steps":["trace[1123428861] 'process raft request' (duration: 128.980465ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:46.930876Z","caller":"traceutil/trace.go:171","msg":"trace[859264263] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"139.149137ms","start":"2026-06-24T09:38:46.791702Z","end":"2026-06-24T09:38:46.930851Z","steps":["trace[859264263] 'process raft request' (duration: 105.71863ms)","trace[859264263] 'compare' (duration: 33.317084ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T09:38:49.008854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.08159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T09:38:49.008915Z","caller":"traceutil/trace.go:171","msg":"trace[691809473] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:920; }","duration":"204.185794ms","start":"2026-06-24T09:38:48.804717Z","end":"2026-06-24T09:38:49.008902Z","steps":["trace[691809473] 'count revisions from in-memory index tree' (duration: 203.959226ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:53.453197Z","caller":"traceutil/trace.go:171","msg":"trace[1278100870] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"207.332705ms","start":"2026-06-24T09:38:53.245843Z","end":"2026-06-24T09:38:53.453175Z","steps":["trace[1278100870] 'process raft request' (duration: 207.280963ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:38:53.453277Z","caller":"traceutil/trace.go:171","msg":"trace[1642107362] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"207.50067ms","start":"2026-06-24T09:38:53.245737Z","end":"2026-06-24T09:38:53.453238Z","steps":["trace[1642107362] 'process raft request' (duration: 155.209198ms)","trace[1642107362] 'compare' (duration: 52.038284ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T09:39:03.936925Z","caller":"traceutil/trace.go:171","msg":"trace[205933190] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"105.601206ms","start":"2026-06-24T09:39:03.831305Z","end":"2026-06-24T09:39:03.936907Z","steps":["trace[205933190] 'process raft request' (duration: 105.472152ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:39:05.830112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.439203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T09:39:05.830193Z","caller":"traceutil/trace.go:171","msg":"trace[2046068930] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:994; }","duration":"105.572336ms","start":"2026-06-24T09:39:05.724602Z","end":"2026-06-24T09:39:05.830174Z","steps":["trace[2046068930] 'range keys from in-memory index tree' (duration: 105.34069ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:39:08.120174Z","caller":"traceutil/trace.go:171","msg":"trace[1768084944] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"105.68713ms","start":"2026-06-24T09:39:08.014458Z","end":"2026-06-24T09:39:08.120145Z","steps":["trace[1768084944] 'process raft request' (duration: 105.052634ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:39:08.257494Z","caller":"traceutil/trace.go:171","msg":"trace[1487414362] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"124.122782ms","start":"2026-06-24T09:39:08.133342Z","end":"2026-06-24T09:39:08.257465Z","steps":["trace[1487414362] 'process raft request' (duration: 110.09839ms)","trace[1487414362] 'compare' (duration: 13.914699ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T09:39:09.813886Z","caller":"traceutil/trace.go:171","msg":"trace[771527338] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"132.038302ms","start":"2026-06-24T09:39:09.681824Z","end":"2026-06-24T09:39:09.813863Z","steps":["trace[771527338] 'process raft request' (duration: 131.882728ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:39:09.823889Z","caller":"traceutil/trace.go:171","msg":"trace[1926420679] linearizableReadLoop","detail":"{readStateIndex:1055; appliedIndex:1053; }","duration":"100.009376ms","start":"2026-06-24T09:39:09.723868Z","end":"2026-06-24T09:39:09.823877Z","steps":["trace[1926420679] 'read index received' (duration: 89.896435ms)","trace[1926420679] 'applied index is now lower than readState.Index' (duration: 10.112121ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T09:39:09.823998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.110519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T09:39:09.824051Z","caller":"traceutil/trace.go:171","msg":"trace[1719624729] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1012; }","duration":"100.209221ms","start":"2026-06-24T09:39:09.723832Z","end":"2026-06-24T09:39:09.824041Z","steps":["trace[1719624729] 'agreement among raft nodes before linearized reading' (duration: 100.090058ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:39:09.824044Z","caller":"traceutil/trace.go:171","msg":"trace[389664828] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"141.921178ms","start":"2026-06-24T09:39:09.682096Z","end":"2026-06-24T09:39:09.824017Z","steps":["trace[389664828] 'process raft request' (duration: 141.727093ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:40:04.405124Z","caller":"traceutil/trace.go:171","msg":"trace[2045166828] transaction","detail":"{read_only:false; response_revision:1190; number_of_response:1; }","duration":"147.565495ms","start":"2026-06-24T09:40:04.257531Z","end":"2026-06-24T09:40:04.405097Z","steps":["trace[2045166828] 'process raft request' (duration: 147.419993ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:40:23.551026Z","caller":"traceutil/trace.go:171","msg":"trace[1722426789] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"211.274771ms","start":"2026-06-24T09:40:23.339733Z","end":"2026-06-24T09:40:23.551008Z","steps":["trace[1722426789] 'process raft request' (duration: 211.163659ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:40:32.093407Z","caller":"traceutil/trace.go:171","msg":"trace[1654242640] linearizableReadLoop","detail":"{readStateIndex:1376; appliedIndex:1375; }","duration":"122.33276ms","start":"2026-06-24T09:40:31.971055Z","end":"2026-06-24T09:40:32.093388Z","steps":["trace[1654242640] 'read index received' (duration: 122.163878ms)","trace[1654242640] 'applied index is now lower than readState.Index' (duration: 167.532µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T09:40:32.093751Z","caller":"traceutil/trace.go:171","msg":"trace[1674112279] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"185.424221ms","start":"2026-06-24T09:40:31.908313Z","end":"2026-06-24T09:40:32.093737Z","steps":["trace[1674112279] 'process raft request' (duration: 184.965034ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:40:32.094147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.849711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-24T09:40:32.094204Z","caller":"traceutil/trace.go:171","msg":"trace[2072177091] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1315; }","duration":"107.939663ms","start":"2026-06-24T09:40:31.986253Z","end":"2026-06-24T09:40:32.094192Z","steps":["trace[2072177091] 'agreement among raft nodes before linearized reading' (duration: 107.74497ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:40:32.094413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.362225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-24T09:40:32.094451Z","caller":"traceutil/trace.go:171","msg":"trace[1846192452] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1315; }","duration":"123.433387ms","start":"2026-06-24T09:40:31.971009Z","end":"2026-06-24T09:40:32.094442Z","steps":["trace[1846192452] 'agreement among raft nodes before linearized reading' (duration: 123.338655ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:40:32.500441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.608283ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T09:40:32.500646Z","caller":"traceutil/trace.go:171","msg":"trace[151803139] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1315; }","duration":"371.846516ms","start":"2026-06-24T09:40:32.12876Z","end":"2026-06-24T09:40:32.500607Z","steps":["trace[151803139] 'range keys from in-memory index tree' (duration: 371.575822ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:40:32.501113Z","caller":"traceutil/trace.go:171","msg":"trace[439234093] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"401.208498ms","start":"2026-06-24T09:40:32.099825Z","end":"2026-06-24T09:40:32.501034Z","steps":["trace[439234093] 'process raft request' (duration: 401.069626ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:40:32.501401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:40:32.099819Z","time spent":"401.40861ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T09:40:32.501421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.894133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-06-24T09:40:32.501516Z","caller":"traceutil/trace.go:171","msg":"trace[202167790] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1317; }","duration":"401.010194ms","start":"2026-06-24T09:40:32.100483Z","end":"2026-06-24T09:40:32.501494Z","steps":["trace[202167790] 'agreement among raft nodes before linearized reading' (duration: 400.847212ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:40:32.501595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:40:32.100479Z","time spent":"401.102726ms","remote":"127.0.0.1:43216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":141,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"info","ts":"2026-06-24T09:40:32.500977Z","caller":"traceutil/trace.go:171","msg":"trace[1358542540] linearizableReadLoop","detail":"{readStateIndex:1378; appliedIndex:1376; }","duration":"400.452156ms","start":"2026-06-24T09:40:32.100496Z","end":"2026-06-24T09:40:32.500949Z","steps":["trace[1358542540] 'read index received' (duration: 369.246687ms)","trace[1358542540] 'applied index is now lower than readState.Index' (duration: 31.203609ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T09:40:32.501959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.373735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T09:40:32.502014Z","caller":"traceutil/trace.go:171","msg":"trace[1142956254] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1317; }","duration":"149.447556ms","start":"2026-06-24T09:40:32.352552Z","end":"2026-06-24T09:40:32.502Z","steps":["trace[1142956254] 'agreement among raft nodes before linearized reading' (duration: 149.358615ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:40:32.502118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.293482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-24T09:40:32.502178Z","caller":"traceutil/trace.go:171","msg":"trace[1196747007] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1317; }","duration":"151.393124ms","start":"2026-06-24T09:40:32.350771Z","end":"2026-06-24T09:40:32.502164Z","steps":["trace[1196747007] 'agreement among raft nodes before linearized reading' (duration: 151.223162ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T09:40:32.502259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.825251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:113488"} {"level":"info","ts":"2026-06-24T09:40:32.502608Z","caller":"traceutil/trace.go:171","msg":"trace[1361090088] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1317; }","duration":"401.156197ms","start":"2026-06-24T09:40:32.101185Z","end":"2026-06-24T09:40:32.502341Z","steps":["trace[1361090088] 'agreement among raft nodes before linearized reading' (duration: 400.67647ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T09:40:32.502759Z","caller":"traceutil/trace.go:171","msg":"trace[1756081988] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"403.036395ms","start":"2026-06-24T09:40:32.099693Z","end":"2026-06-24T09:40:32.502729Z","steps":["trace[1756081988] 'process raft request' (duration: 370.032278ms)","trace[1756081988] 'compare' (duration: 30.932945ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T09:40:32.502927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:40:32.099683Z","time spent":"403.169017ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T09:40:32.502998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T09:40:32.101181Z","time spent":"401.728725ms","remote":"127.0.0.1:43214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":113511,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-06-24T09:40:32.951864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.26958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T09:40:32.951958Z","caller":"traceutil/trace.go:171","msg":"trace[124242698] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1319; }","duration":"226.386352ms","start":"2026-06-24T09:40:32.725554Z","end":"2026-06-24T09:40:32.951941Z","steps":["trace[124242698] 'range keys from in-memory index tree' (duration: 226.195249ms)"],"step_count":1}