{"level":"warn","ts":"2026-08-14T07:04:12.056128Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-14T07:04:12.056236Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.38:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.38:2380","--initial-cluster=instance=https://199.204.45.38:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.38:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.38:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-08-14T07:04:12.056309Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-14T07:04:12.056321Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-08-14T07:04:12.056339Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-14T07:04:12.056954Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"]} {"level":"info","ts":"2026-08-14T07:04:12.057026Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.38:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-08-14T07:04:12.062571Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.379448ms"} {"level":"info","ts":"2026-08-14T07:04:12.069406Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"331455d6226d3423","cluster-id":"25c7803fb83a1455"} {"level":"info","ts":"2026-08-14T07:04:12.069476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=()"} {"level":"info","ts":"2026-08-14T07:04:12.069494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 0"} {"level":"info","ts":"2026-08-14T07:04:12.069506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 331455d6226d3423 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-14T07:04:12.069528Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 1"} {"level":"info","ts":"2026-08-14T07:04:12.069567Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"warn","ts":"2026-08-14T07:04:12.0741Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-14T07:04:12.076436Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-14T07:04:12.077665Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-08-14T07:04:12.080039Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"331455d6226d3423","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-14T07:04:12.080115Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"331455d6226d3423","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-14T07:04:12.082769Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-14T07:04:12.082894Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-14T07:04:12.082914Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-14T07:04:12.084673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"info","ts":"2026-08-14T07:04:12.084783Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","added-peer-id":"331455d6226d3423","added-peer-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-08-14T07:04:12.086271Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-14T07:04:12.086329Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-08-14T07:04:12.086497Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-08-14T07:04:12.086851Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"331455d6226d3423","initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-14T07:04:12.086922Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-14T07:04:12.770291Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 is starting a new election at term 1"} {"level":"info","ts":"2026-08-14T07:04:12.770358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-14T07:04:12.770381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgPreVoteResp from 331455d6226d3423 at term 1"} {"level":"info","ts":"2026-08-14T07:04:12.770401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became candidate at term 2"} {"level":"info","ts":"2026-08-14T07:04:12.770413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgVoteResp from 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-08-14T07:04:12.770429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became leader at term 2"} {"level":"info","ts":"2026-08-14T07:04:12.770442Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 331455d6226d3423 elected leader 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-08-14T07:04:12.771565Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T07:04:12.772924Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"331455d6226d3423","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.38:2379]}","request-path":"/0/members/331455d6226d3423/attributes","cluster-id":"25c7803fb83a1455","publish-timeout":"7s"} {"level":"info","ts":"2026-08-14T07:04:12.772948Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T07:04:12.77294Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-14T07:04:12.772989Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-14T07:04:12.773086Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T07:04:12.773343Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T07:04:12.773801Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-14T07:04:12.773865Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-14T07:04:12.776773Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-14T07:04:12.793352Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.38:2379"} {"level":"info","ts":"2026-08-14T07:04:16.337099Z","caller":"traceutil/trace.go:171","msg":"trace[1450634233] transaction","detail":"{read_only:false; response_revision:251; number_of_response:1; }","duration":"101.84946ms","start":"2026-08-14T07:04:16.235224Z","end":"2026-08-14T07:04:16.337073Z","steps":["trace[1450634233] 'process raft request' (duration: 101.739968ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:04:16.807122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.492585ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-14T07:04:16.807278Z","caller":"traceutil/trace.go:171","msg":"trace[1794950616] transaction","detail":"{read_only:false; response_revision:252; number_of_response:1; }","duration":"463.496743ms","start":"2026-08-14T07:04:16.343749Z","end":"2026-08-14T07:04:16.807246Z","steps":["trace[1794950616] 'process raft request' (duration: 166.218119ms)","trace[1794950616] 'compare' (duration: 294.614506ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T07:04:16.80733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:04:16.343733Z","time spent":"463.572865ms","remote":"127.0.0.1:37672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":525,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T07:04:53.349968Z","caller":"traceutil/trace.go:171","msg":"trace[2097223808] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"121.168315ms","start":"2026-08-14T07:04:53.228735Z","end":"2026-08-14T07:04:53.349903Z","steps":["trace[2097223808] 'process raft request' (duration: 116.41863ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T07:04:53.548252Z","caller":"traceutil/trace.go:171","msg":"trace[1532241418] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"129.726923ms","start":"2026-08-14T07:04:53.418509Z","end":"2026-08-14T07:04:53.548236Z","steps":["trace[1532241418] 'read index received' (duration: 129.682462ms)","trace[1532241418] 'applied index is now lower than readState.Index' (duration: 43.061µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T07:04:53.54837Z","caller":"traceutil/trace.go:171","msg":"trace[534378412] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"144.631954ms","start":"2026-08-14T07:04:53.403677Z","end":"2026-08-14T07:04:53.548309Z","steps":["trace[534378412] 'process raft request' (duration: 144.46955ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:04:53.548496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.930648ms","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-08-14T07:04:53.548558Z","caller":"traceutil/trace.go:171","msg":"trace[1462244845] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:633; }","duration":"130.047891ms","start":"2026-08-14T07:04:53.418502Z","end":"2026-08-14T07:04:53.54855Z","steps":["trace[1462244845] 'agreement among raft nodes before linearized reading' (duration: 129.934699ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:04:53.548734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.184074ms","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-08-14T07:04:53.548842Z","caller":"traceutil/trace.go:171","msg":"trace[900421486] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:633; }","duration":"130.339397ms","start":"2026-08-14T07:04:53.418482Z","end":"2026-08-14T07:04:53.548821Z","steps":["trace[900421486] 'agreement among raft nodes before linearized reading' (duration: 129.878447ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:04:54.10264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.417857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T07:04:54.102819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.445293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T07:04:54.102809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.403122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T07:04:54.102909Z","caller":"traceutil/trace.go:171","msg":"trace[105923948] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:633; }","duration":"420.539314ms","start":"2026-08-14T07:04:53.682354Z","end":"2026-08-14T07:04:54.102893Z","steps":["trace[105923948] 'count revisions from in-memory index tree' (duration: 420.34791ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T07:04:54.102903Z","caller":"traceutil/trace.go:171","msg":"trace[1481631583] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:633; }","duration":"420.566925ms","start":"2026-08-14T07:04:53.682318Z","end":"2026-08-14T07:04:54.102885Z","steps":["trace[1481631583] 'range keys from in-memory index tree' (duration: 420.394952ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:04:54.102968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:04:53.68235Z","time spent":"420.608697ms","remote":"127.0.0.1:58658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-08-14T07:04:54.102957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.347965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T07:04:54.102956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.535915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T07:04:54.102975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:04:53.682302Z","time spent":"420.661978ms","remote":"127.0.0.1:58658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-08-14T07:04:54.103003Z","caller":"traceutil/trace.go:171","msg":"trace[112703769] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:633; }","duration":"456.413846ms","start":"2026-08-14T07:04:53.646578Z","end":"2026-08-14T07:04:54.102992Z","steps":["trace[112703769] 'count revisions from in-memory index tree' (duration: 456.288984ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:04:54.10304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:04:53.64657Z","time spent":"456.460407ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-08-14T07:04:54.10305Z","caller":"traceutil/trace.go:171","msg":"trace[108157185] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:633; }","duration":"420.724859ms","start":"2026-08-14T07:04:53.682279Z","end":"2026-08-14T07:04:54.103004Z","steps":["trace[108157185] 'range keys from in-memory index tree' (duration: 420.441233ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:04:54.103144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:04:53.682263Z","time spent":"420.865051ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"info","ts":"2026-08-14T07:04:54.103327Z","caller":"traceutil/trace.go:171","msg":"trace[207090468] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:633; }","duration":"456.521939ms","start":"2026-08-14T07:04:53.646189Z","end":"2026-08-14T07:04:54.102711Z","steps":["trace[207090468] 'range keys from in-memory index tree' (duration: 456.345755ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:04:54.103396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:04:53.646137Z","time spent":"457.244445ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-08-14T07:04:54.458285Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757022432089746025,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-14T07:04:54.535569Z","caller":"traceutil/trace.go:171","msg":"trace[307013828] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"577.94661ms","start":"2026-08-14T07:04:53.957585Z","end":"2026-08-14T07:04:54.535532Z","steps":["trace[307013828] 'read index received' (duration: 577.192374ms)","trace[307013828] 'applied index is now lower than readState.Index' (duration: 752.766µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T07:04:54.535717Z","caller":"traceutil/trace.go:171","msg":"trace[1644446070] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"597.955362ms","start":"2026-08-14T07:04:53.937701Z","end":"2026-08-14T07:04:54.535656Z","steps":["trace[1644446070] 'process raft request' (duration: 597.327188ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:04:54.535867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.623472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T07:04:54.535896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.436133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-14T07:04:54.535926Z","caller":"traceutil/trace.go:171","msg":"trace[163705795] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:634; }","duration":"471.747225ms","start":"2026-08-14T07:04:54.064152Z","end":"2026-08-14T07:04:54.535899Z","steps":["trace[163705795] 'agreement among raft nodes before linearized reading' (duration: 471.633573ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:04:54.53592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.313718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hrl99\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-08-14T07:04:54.535959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:04:54.06413Z","time spent":"471.821887ms","remote":"127.0.0.1:37624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-14T07:04:54.535949Z","caller":"traceutil/trace.go:171","msg":"trace[477537938] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:634; }","duration":"247.529625ms","start":"2026-08-14T07:04:54.288405Z","end":"2026-08-14T07:04:54.535935Z","steps":["trace[477537938] 'agreement among raft nodes before linearized reading' (duration: 247.383532ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T07:04:54.535996Z","caller":"traceutil/trace.go:171","msg":"trace[931812604] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hrl99; range_end:; response_count:1; response_revision:634; }","duration":"578.420581ms","start":"2026-08-14T07:04:53.957556Z","end":"2026-08-14T07:04:54.535976Z","steps":["trace[931812604] 'agreement among raft nodes before linearized reading' (duration: 578.179846ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:04:54.53605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:04:53.957523Z","time spent":"578.518042ms","remote":"127.0.0.1:37790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16983,"request content":"key:\"/registry/pods/kube-system/cilium-hrl99\" "} {"level":"warn","ts":"2026-08-14T07:04:54.536078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.339735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-14T07:04:54.536132Z","caller":"traceutil/trace.go:171","msg":"trace[896999078] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:634; }","duration":"244.410576ms","start":"2026-08-14T07:04:54.291709Z","end":"2026-08-14T07:04:54.536119Z","steps":["trace[896999078] 'agreement among raft nodes before linearized reading' (duration: 244.273003ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:04:54.536177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.198387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-14T07:04:54.536199Z","caller":"traceutil/trace.go:171","msg":"trace[119502297] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:634; }","duration":"434.299399ms","start":"2026-08-14T07:04:54.101894Z","end":"2026-08-14T07:04:54.536193Z","steps":["trace[119502297] 'agreement among raft nodes before linearized reading' (duration: 434.253738ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:04:54.536217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:04:54.101882Z","time spent":"434.330961ms","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-14T07:04:54.535902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.109339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-14T07:04:54.53627Z","caller":"traceutil/trace.go:171","msg":"trace[1952609065] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:634; }","duration":"258.532039ms","start":"2026-08-14T07:04:54.277732Z","end":"2026-08-14T07:04:54.536264Z","steps":["trace[1952609065] 'agreement among raft nodes before linearized reading' (duration: 258.076068ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:04:54.536323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:04:53.937675Z","time spent":"598.224187ms","remote":"127.0.0.1:37672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T07:04:56.08857Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757022432089746045,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T07:04:56.589367Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757022432089746045,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T07:04:57.090496Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757022432089746045,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T07:04:57.590685Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757022432089746045,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T07:04:58.037485Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.07455296s","expected-duration":"1s"} {"level":"info","ts":"2026-08-14T07:04:58.037918Z","caller":"traceutil/trace.go:171","msg":"trace[877658153] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"3.075041292s","start":"2026-08-14T07:04:54.962858Z","end":"2026-08-14T07:04:58.037899Z","steps":["trace[877658153] 'process raft request' (duration: 3.074952589s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:04:58.038018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:04:54.962843Z","time spent":"3.075121424s","remote":"127.0.0.1:37664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":765,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T07:04:58.042194Z","caller":"traceutil/trace.go:171","msg":"trace[648096420] linearizableReadLoop","detail":"{readStateIndex:670; appliedIndex:668; }","duration":"2.454437489s","start":"2026-08-14T07:04:55.587744Z","end":"2026-08-14T07:04:58.042182Z","steps":["trace[648096420] 'read index received' (duration: 2.450051002s)","trace[648096420] 'applied index is now lower than readState.Index' (duration: 4.385887ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T07:04:58.042367Z","caller":"traceutil/trace.go:171","msg":"trace[1938989318] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"3.066579335s","start":"2026-08-14T07:04:54.975756Z","end":"2026-08-14T07:04:58.042335Z","steps":["trace[1938989318] 'process raft request' (duration: 3.06634678s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:04:58.042444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.454652035s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.38\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-08-14T07:04:58.042525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.490472826s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-14T07:04:58.042529Z","caller":"traceutil/trace.go:171","msg":"trace[867097634] range","detail":"{range_begin:/registry/masterleases/199.204.45.38; range_end:; response_count:1; response_revision:648; }","duration":"2.454817527s","start":"2026-08-14T07:04:55.587689Z","end":"2026-08-14T07:04:58.042506Z","steps":["trace[867097634] 'agreement among raft nodes before linearized reading' (duration: 2.454601793s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:04:58.04253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.978008801s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T07:04:58.042576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:04:55.587661Z","time spent":"2.45490649s","remote":"127.0.0.1:37640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/199.204.45.38\" "} {"level":"warn","ts":"2026-08-14T07:04:58.042594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.490807335s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-08-14T07:04:58.042618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:04:54.975726Z","time spent":"3.066706348s","remote":"127.0.0.1:37790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17228,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T07:04:58.042626Z","caller":"traceutil/trace.go:171","msg":"trace[1821532081] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:648; }","duration":"1.978158354s","start":"2026-08-14T07:04:56.064442Z","end":"2026-08-14T07:04:58.0426Z","steps":["trace[1821532081] 'agreement among raft nodes before linearized reading' (duration: 1.97795765s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:04:58.04266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.490970727s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-14T07:04:58.042661Z","caller":"traceutil/trace.go:171","msg":"trace[1787457308] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:648; }","duration":"1.490906326s","start":"2026-08-14T07:04:56.551738Z","end":"2026-08-14T07:04:58.042645Z","steps":["trace[1787457308] 'agreement among raft nodes before linearized reading' (duration: 1.490706632s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:04:58.042677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:04:56.064422Z","time spent":"1.978245836s","remote":"127.0.0.1:37624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-14T07:04:58.042688Z","caller":"traceutil/trace.go:171","msg":"trace[1521683690] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:648; }","duration":"1.491000008s","start":"2026-08-14T07:04:56.551681Z","end":"2026-08-14T07:04:58.042681Z","steps":["trace[1521683690] 'agreement among raft nodes before linearized reading' (duration: 1.490917386s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:04:58.042696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:04:56.551727Z","time spent":"1.490963377s","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-14T07:04:58.042716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:04:56.551613Z","time spent":"1.491097361s","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-14T07:04:58.042568Z","caller":"traceutil/trace.go:171","msg":"trace[1067716234] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:648; }","duration":"1.490526818s","start":"2026-08-14T07:04:56.552022Z","end":"2026-08-14T07:04:58.042549Z","steps":["trace[1067716234] 'agreement among raft nodes before linearized reading' (duration: 1.490416556s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:04:58.042792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:04:56.552016Z","time spent":"1.490770603s","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-14T07:04:58.042901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.491089171s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-14T07:04:58.04293Z","caller":"traceutil/trace.go:171","msg":"trace[1737946691] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:648; }","duration":"1.491153831s","start":"2026-08-14T07:04:56.551768Z","end":"2026-08-14T07:04:58.042922Z","steps":["trace[1737946691] 'agreement among raft nodes before linearized reading' (duration: 1.4906299s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:04:58.042948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:04:56.551748Z","time spent":"1.491195903s","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-14T07:05:12.556526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.889753ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T07:05:12.556639Z","caller":"traceutil/trace.go:171","msg":"trace[1725166744] linearizableReadLoop","detail":"{readStateIndex:828; appliedIndex:827; }","duration":"437.955049ms","start":"2026-08-14T07:05:12.118667Z","end":"2026-08-14T07:05:12.556622Z","steps":["trace[1725166744] 'read index received' (duration: 9.461858ms)","trace[1725166744] 'applied index is now lower than readState.Index' (duration: 428.491341ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T07:05:12.556897Z","caller":"traceutil/trace.go:171","msg":"trace[349456771] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"439.223746ms","start":"2026-08-14T07:05:12.117656Z","end":"2026-08-14T07:05:12.55688Z","steps":["trace[349456771] 'process raft request' (duration: 185.857953ms)","trace[349456771] 'compare' (duration: 252.403152ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T07:05:12.556976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:05:12.117644Z","time spent":"439.294189ms","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T07:05:12.557418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.598498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-08-14T07:05:12.557463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.44011ms","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-08-14T07:05:12.557501Z","caller":"traceutil/trace.go:171","msg":"trace[311340670] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:802; }","duration":"168.503762ms","start":"2026-08-14T07:05:12.388986Z","end":"2026-08-14T07:05:12.55749Z","steps":["trace[311340670] 'agreement among raft nodes before linearized reading' (duration: 168.374319ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:05:12.557477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.773968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-08-14T07:05:12.557582Z","caller":"traceutil/trace.go:171","msg":"trace[1706560890] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:802; }","duration":"438.901741ms","start":"2026-08-14T07:05:12.118643Z","end":"2026-08-14T07:05:12.557545Z","steps":["trace[1706560890] 'agreement among raft nodes before linearized reading' (duration: 438.603553ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:05:12.557641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:05:12.118634Z","time spent":"438.995643ms","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-14T07:05:12.557503Z","caller":"traceutil/trace.go:171","msg":"trace[411277655] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:802; }","duration":"435.71965ms","start":"2026-08-14T07:05:12.121766Z","end":"2026-08-14T07:05:12.557486Z","steps":["trace[411277655] 'agreement among raft nodes before linearized reading' (duration: 435.504315ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:05:12.557803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:05:12.121757Z","time spent":"435.992776ms","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-14T07:05:56.721005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.911552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-08-14T07:05:56.721456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.845134ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T07:05:56.721536Z","caller":"traceutil/trace.go:171","msg":"trace[1075561203] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1045; }","duration":"411.368663ms","start":"2026-08-14T07:05:56.310007Z","end":"2026-08-14T07:05:56.721376Z","steps":["trace[1075561203] 'range keys from in-memory index tree' (duration: 410.711958ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T07:05:56.721569Z","caller":"traceutil/trace.go:171","msg":"trace[826363612] linearizableReadLoop","detail":"{readStateIndex:1085; appliedIndex:1084; }","duration":"121.567205ms","start":"2026-08-14T07:05:56.599984Z","end":"2026-08-14T07:05:56.721551Z","steps":["trace[826363612] 'read index received' (duration: 79.422µs)","trace[826363612] 'applied index is now lower than readState.Index' (duration: 121.486173ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T07:05:56.721599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:05:56.309983Z","time spent":"411.602958ms","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-14T07:05:56.721642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.665477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T07:05:56.721674Z","caller":"traceutil/trace.go:171","msg":"trace[1861868075] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1046; }","duration":"121.752668ms","start":"2026-08-14T07:05:56.599913Z","end":"2026-08-14T07:05:56.721665Z","steps":["trace[1861868075] 'agreement among raft nodes before linearized reading' (duration: 121.686927ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T07:05:56.721913Z","caller":"traceutil/trace.go:171","msg":"trace[1066741148] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"386.896963ms","start":"2026-08-14T07:05:56.335003Z","end":"2026-08-14T07:05:56.7219Z","steps":["trace[1066741148] 'process raft request' (duration: 257.497946ms)","trace[1066741148] 'compare' (duration: 128.606089ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T07:05:56.722005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:05:56.334975Z","time spent":"386.996804ms","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T07:06:12.896534Z","caller":"traceutil/trace.go:171","msg":"trace[1370826678] transaction","detail":"{read_only:false; response_revision:1150; number_of_response:1; }","duration":"121.978976ms","start":"2026-08-14T07:06:12.774508Z","end":"2026-08-14T07:06:12.896487Z","steps":["trace[1370826678] 'process raft request' (duration: 121.791182ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:06:17.654447Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757022432089747156,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T07:06:17.750892Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.134442601s","expected-duration":"1s"} {"level":"info","ts":"2026-08-14T07:06:17.751268Z","caller":"traceutil/trace.go:171","msg":"trace[1908276123] transaction","detail":"{read_only:false; response_revision:1163; number_of_response:1; }","duration":"1.134892101s","start":"2026-08-14T07:06:16.616345Z","end":"2026-08-14T07:06:17.751238Z","steps":["trace[1908276123] 'process raft request' (duration: 1.134694167s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:06:17.751457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:06:16.616329Z","time spent":"1.135029634s","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T07:06:17.752184Z","caller":"traceutil/trace.go:171","msg":"trace[2140092743] transaction","detail":"{read_only:false; response_revision:1164; number_of_response:1; }","duration":"844.974093ms","start":"2026-08-14T07:06:16.907203Z","end":"2026-08-14T07:06:17.752177Z","steps":["trace[2140092743] 'process raft request' (duration: 844.789789ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:06:17.752261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:06:16.907128Z","time spent":"845.078644ms","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T07:06:17.752079Z","caller":"traceutil/trace.go:171","msg":"trace[631487288] linearizableReadLoop","detail":"{readStateIndex:1208; appliedIndex:1206; }","duration":"746.80259ms","start":"2026-08-14T07:06:17.005263Z","end":"2026-08-14T07:06:17.752065Z","steps":["trace[631487288] 'read index received' (duration: 745.817288ms)","trace[631487288] 'applied index is now lower than readState.Index' (duration: 984.752µs)"],"step_count":2} {"level":"warn","ts":"2026-08-14T07:06:17.752507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.680536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-14T07:06:17.752524Z","caller":"traceutil/trace.go:171","msg":"trace[1960047483] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1164; }","duration":"746.718728ms","start":"2026-08-14T07:06:17.0058Z","end":"2026-08-14T07:06:17.752519Z","steps":["trace[1960047483] 'agreement among raft nodes before linearized reading' (duration: 746.661826ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:06:17.752539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:06:17.005792Z","time spent":"746.743068ms","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-14T07:06:17.752623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"745.95036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-14T07:06:17.752635Z","caller":"traceutil/trace.go:171","msg":"trace[790938424] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1164; }","duration":"745.999231ms","start":"2026-08-14T07:06:17.006632Z","end":"2026-08-14T07:06:17.752631Z","steps":["trace[790938424] 'agreement among raft nodes before linearized reading' (duration: 745.9621ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:06:17.752647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:06:17.006613Z","time spent":"746.031061ms","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-14T07:06:17.752694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"745.9733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-14T07:06:17.752762Z","caller":"traceutil/trace.go:171","msg":"trace[1931628876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1164; }","duration":"746.056032ms","start":"2026-08-14T07:06:17.00669Z","end":"2026-08-14T07:06:17.752746Z","steps":["trace[1931628876] 'agreement among raft nodes before linearized reading' (duration: 745.822116ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:06:17.752796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"745.561631ms","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-08-14T07:06:17.752811Z","caller":"traceutil/trace.go:171","msg":"trace[419447766] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1164; }","duration":"745.596551ms","start":"2026-08-14T07:06:17.00721Z","end":"2026-08-14T07:06:17.752806Z","steps":["trace[419447766] 'agreement among raft nodes before linearized reading' (duration: 745.5579ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:06:17.752825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:06:17.007199Z","time spent":"745.621312ms","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-14T07:06:17.752816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:06:17.006613Z","time spent":"746.194395ms","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-14T07:06:17.75291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"747.648459ms","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-08-14T07:06:17.752945Z","caller":"traceutil/trace.go:171","msg":"trace[1289295915] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1164; }","duration":"747.724161ms","start":"2026-08-14T07:06:17.005216Z","end":"2026-08-14T07:06:17.752941Z","steps":["trace[1289295915] 'agreement among raft nodes before linearized reading' (duration: 747.208999ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:06:17.753019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:06:17.005197Z","time spent":"747.817573ms","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-14T07:06:30.302718Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757022432089747258,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-14T07:06:30.679466Z","caller":"traceutil/trace.go:171","msg":"trace[156816210] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"892.343934ms","start":"2026-08-14T07:06:29.787096Z","end":"2026-08-14T07:06:30.67944Z","steps":["trace[156816210] 'process raft request' (duration: 892.199171ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:06:30.679622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:06:29.787073Z","time spent":"892.462276ms","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T07:06:30.698745Z","caller":"traceutil/trace.go:171","msg":"trace[154216589] linearizableReadLoop","detail":"{readStateIndex:1250; appliedIndex:1248; }","duration":"896.891598ms","start":"2026-08-14T07:06:29.801835Z","end":"2026-08-14T07:06:30.698727Z","steps":["trace[154216589] 'read index received' (duration: 877.522189ms)","trace[154216589] 'applied index is now lower than readState.Index' (duration: 19.368719ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T07:06:30.698852Z","caller":"traceutil/trace.go:171","msg":"trace[1604098214] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"404.323778ms","start":"2026-08-14T07:06:30.294493Z","end":"2026-08-14T07:06:30.698817Z","steps":["trace[1604098214] 'process raft request' (duration: 404.135034ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:06:30.69908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"888.72911ms","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-08-14T07:06:30.699105Z","caller":"traceutil/trace.go:171","msg":"trace[68547445] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1204; }","duration":"888.765051ms","start":"2026-08-14T07:06:29.810333Z","end":"2026-08-14T07:06:30.699098Z","steps":["trace[68547445] 'agreement among raft nodes before linearized reading' (duration: 888.71093ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:06:30.699131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:06:29.810326Z","time spent":"888.799911ms","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-14T07:06:30.698922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"897.063574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-08-14T07:06:30.699209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.995133ms","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":"warn","ts":"2026-08-14T07:06:30.699194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.035934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T07:06:30.699229Z","caller":"traceutil/trace.go:171","msg":"trace[1632692812] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1204; }","duration":"897.416432ms","start":"2026-08-14T07:06:29.801788Z","end":"2026-08-14T07:06:30.699205Z","steps":["trace[1632692812] 'agreement among raft nodes before linearized reading' (duration: 897.025292ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:06:30.699248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"882.154597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-14T07:06:30.699266Z","caller":"traceutil/trace.go:171","msg":"trace[643034339] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1204; }","duration":"882.099035ms","start":"2026-08-14T07:06:29.817152Z","end":"2026-08-14T07:06:30.699251Z","steps":["trace[643034339] 'agreement among raft nodes before linearized reading' (duration: 881.926521ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T07:06:30.699281Z","caller":"traceutil/trace.go:171","msg":"trace[768762563] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1204; }","duration":"636.178329ms","start":"2026-08-14T07:06:30.063084Z","end":"2026-08-14T07:06:30.699262Z","steps":["trace[768762563] 'agreement among raft nodes before linearized reading' (duration: 636.030065ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T07:06:30.699298Z","caller":"traceutil/trace.go:171","msg":"trace[301597239] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1204; }","duration":"882.233818ms","start":"2026-08-14T07:06:29.817053Z","end":"2026-08-14T07:06:30.699287Z","steps":["trace[301597239] 'agreement among raft nodes before linearized reading' (duration: 882.029493ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:06:30.699324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:06:29.817133Z","time spent":"882.183617ms","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-14T07:06:30.699339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:06:30.063059Z","time spent":"636.25903ms","remote":"127.0.0.1:37624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-14T07:06:30.699345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:06:29.817044Z","time spent":"882.291659ms","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-14T07:06:30.699304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:06:29.801765Z","time spent":"897.511114ms","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-14T07:06:30.699366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:06:30.29447Z","time spent":"404.532625ms","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T07:06:30.699474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.728146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-14T07:06:30.699496Z","caller":"traceutil/trace.go:171","msg":"trace[1807416879] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1204; }","duration":"884.759407ms","start":"2026-08-14T07:06:29.81473Z","end":"2026-08-14T07:06:30.69949Z","steps":["trace[1807416879] 'agreement among raft nodes before linearized reading' (duration: 884.366718ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:06:30.699509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:06:29.814724Z","time spent":"884.781927ms","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-14T07:06:32.992116Z","caller":"traceutil/trace.go:171","msg":"trace[262492330] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"232.75431ms","start":"2026-08-14T07:06:32.759337Z","end":"2026-08-14T07:06:32.992091Z","steps":["trace[262492330] 'process raft request' (duration: 232.483354ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T07:06:32.992356Z","caller":"traceutil/trace.go:171","msg":"trace[1458577283] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"231.275335ms","start":"2026-08-14T07:06:32.761056Z","end":"2026-08-14T07:06:32.992331Z","steps":["trace[1458577283] 'process raft request' (duration: 231.147312ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T07:06:32.992398Z","caller":"traceutil/trace.go:171","msg":"trace[1990888523] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"231.345807ms","start":"2026-08-14T07:06:32.76104Z","end":"2026-08-14T07:06:32.992386Z","steps":["trace[1990888523] 'process raft request' (duration: 230.964978ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T07:06:37.417257Z","caller":"traceutil/trace.go:171","msg":"trace[1287190952] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"101.386557ms","start":"2026-08-14T07:06:37.315842Z","end":"2026-08-14T07:06:37.417228Z","steps":["trace[1287190952] 'process raft request' (duration: 98.885568ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T07:07:06.997985Z","caller":"traceutil/trace.go:171","msg":"trace[1261114865] linearizableReadLoop","detail":"{readStateIndex:1467; appliedIndex:1466; }","duration":"130.161936ms","start":"2026-08-14T07:07:06.867805Z","end":"2026-08-14T07:07:06.997967Z","steps":["trace[1261114865] 'read index received' (duration: 130.011593ms)","trace[1261114865] 'applied index is now lower than readState.Index' (duration: 149.663µs)"],"step_count":2} {"level":"warn","ts":"2026-08-14T07:07:06.998085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.267768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T07:07:06.998111Z","caller":"traceutil/trace.go:171","msg":"trace[2091905171] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1412; }","duration":"130.331139ms","start":"2026-08-14T07:07:06.86777Z","end":"2026-08-14T07:07:06.998101Z","steps":["trace[2091905171] 'agreement among raft nodes before linearized reading' (duration: 130.274358ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T07:07:06.998133Z","caller":"traceutil/trace.go:171","msg":"trace[1535496797] transaction","detail":"{read_only:false; response_revision:1412; number_of_response:1; }","duration":"269.493754ms","start":"2026-08-14T07:07:06.728613Z","end":"2026-08-14T07:07:06.998107Z","steps":["trace[1535496797] 'process raft request' (duration: 268.916201ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T07:07:07.048594Z","caller":"traceutil/trace.go:171","msg":"trace[2081033232] transaction","detail":"{read_only:false; response_revision:1413; number_of_response:1; }","duration":"138.354245ms","start":"2026-08-14T07:07:06.910221Z","end":"2026-08-14T07:07:07.048575Z","steps":["trace[2081033232] 'process raft request' (duration: 136.722008ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T07:07:10.64634Z","caller":"traceutil/trace.go:171","msg":"trace[2030731690] transaction","detail":"{read_only:false; response_revision:1430; number_of_response:1; }","duration":"249.311165ms","start":"2026-08-14T07:07:10.397Z","end":"2026-08-14T07:07:10.646311Z","steps":["trace[2030731690] 'process raft request' (duration: 249.152531ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T07:07:31.32927Z","caller":"traceutil/trace.go:171","msg":"trace[575719226] transaction","detail":"{read_only:false; response_revision:1522; number_of_response:1; }","duration":"650.83684ms","start":"2026-08-14T07:07:30.678408Z","end":"2026-08-14T07:07:31.329245Z","steps":["trace[575719226] 'process raft request' (duration: 650.652836ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:07:31.329453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T07:07:30.678382Z","time spent":"650.983083ms","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T07:07:31.336745Z","caller":"traceutil/trace.go:171","msg":"trace[1522336130] linearizableReadLoop","detail":"{readStateIndex:1582; appliedIndex:1580; }","duration":"273.415435ms","start":"2026-08-14T07:07:31.063309Z","end":"2026-08-14T07:07:31.336724Z","steps":["trace[1522336130] 'read index received' (duration: 265.86524ms)","trace[1522336130] 'applied index is now lower than readState.Index' (duration: 7.549275ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T07:07:31.336885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.569059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T07:07:31.336917Z","caller":"traceutil/trace.go:171","msg":"trace[1917085811] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1523; }","duration":"273.658601ms","start":"2026-08-14T07:07:31.063249Z","end":"2026-08-14T07:07:31.336907Z","steps":["trace[1917085811] 'agreement among raft nodes before linearized reading' (duration: 273.59464ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T07:07:31.336891Z","caller":"traceutil/trace.go:171","msg":"trace[350051381] transaction","detail":"{read_only:false; response_revision:1523; number_of_response:1; }","duration":"211.112207ms","start":"2026-08-14T07:07:31.125746Z","end":"2026-08-14T07:07:31.336859Z","steps":["trace[350051381] 'process raft request' (duration: 210.879772ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:07:31.336977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.042357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-08-14T07:07:31.337035Z","caller":"traceutil/trace.go:171","msg":"trace[444253741] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1523; }","duration":"187.13603ms","start":"2026-08-14T07:07:31.149883Z","end":"2026-08-14T07:07:31.337019Z","steps":["trace[444253741] 'agreement among raft nodes before linearized reading' (duration: 186.987036ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T07:07:31.337214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.792479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-14T07:07:31.337231Z","caller":"traceutil/trace.go:171","msg":"trace[1367608529] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1523; }","duration":"185.85141ms","start":"2026-08-14T07:07:31.151374Z","end":"2026-08-14T07:07:31.337225Z","steps":["trace[1367608529] 'agreement among raft nodes before linearized reading' (duration: 185.807029ms)"],"step_count":1}