{"level":"warn","ts":"2026-05-20T21:27:29.95254Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-20T21:27:29.952662Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.232: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.232:2380","--initial-cluster=instance=https://199.19.213.232:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.232:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.232:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-20T21:27:29.952747Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-20T21:27:29.952755Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.232:2380"]} {"level":"info","ts":"2026-05-20T21:27:29.952773Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-20T21:27:29.953591Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.232:2379"]} {"level":"info","ts":"2026-05-20T21:27:29.953671Z","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.232:2380"],"listen-peer-urls":["https://199.19.213.232:2380"],"advertise-client-urls":["https://199.19.213.232:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.232:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.232:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-20T21:27:29.958665Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.737962ms"} {"level":"info","ts":"2026-05-20T21:27:29.968495Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"20a2700e013b1fa5","cluster-id":"b7b35e617ebc7ac7"} {"level":"info","ts":"2026-05-20T21:27:29.96858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 switched to configuration voters=()"} {"level":"info","ts":"2026-05-20T21:27:29.968605Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 became follower at term 0"} {"level":"info","ts":"2026-05-20T21:27:29.96862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 20a2700e013b1fa5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-20T21:27:29.968633Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 became follower at term 1"} {"level":"info","ts":"2026-05-20T21:27:29.968677Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 switched to configuration voters=(2351565160893325221)"} {"level":"warn","ts":"2026-05-20T21:27:29.978063Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-20T21:27:29.980388Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-20T21:27:29.982935Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-20T21:27:29.985972Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"20a2700e013b1fa5","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-20T21:27:29.986695Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"20a2700e013b1fa5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-20T21:27:29.987278Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-20T21:27:29.988114Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-20T21:27:29.988131Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-20T21:27:29.988463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 switched to configuration voters=(2351565160893325221)"} {"level":"info","ts":"2026-05-20T21:27:29.988593Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b7b35e617ebc7ac7","local-member-id":"20a2700e013b1fa5","added-peer-id":"20a2700e013b1fa5","added-peer-peer-urls":["https://199.19.213.232:2380"]} {"level":"info","ts":"2026-05-20T21:27:29.991318Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-20T21:27:29.991439Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.232:2380"} {"level":"info","ts":"2026-05-20T21:27:29.991473Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.232:2380"} {"level":"info","ts":"2026-05-20T21:27:29.991571Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"20a2700e013b1fa5","initial-advertise-peer-urls":["https://199.19.213.232:2380"],"listen-peer-urls":["https://199.19.213.232:2380"],"advertise-client-urls":["https://199.19.213.232:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.232:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-20T21:27:29.991616Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-20T21:27:30.468852Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 is starting a new election at term 1"} {"level":"info","ts":"2026-05-20T21:27:30.468941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-20T21:27:30.468967Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 received MsgPreVoteResp from 20a2700e013b1fa5 at term 1"} {"level":"info","ts":"2026-05-20T21:27:30.468987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 became candidate at term 2"} {"level":"info","ts":"2026-05-20T21:27:30.469003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 received MsgVoteResp from 20a2700e013b1fa5 at term 2"} {"level":"info","ts":"2026-05-20T21:27:30.469024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"20a2700e013b1fa5 became leader at term 2"} {"level":"info","ts":"2026-05-20T21:27:30.469054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 20a2700e013b1fa5 elected leader 20a2700e013b1fa5 at term 2"} {"level":"info","ts":"2026-05-20T21:27:30.4699Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"20a2700e013b1fa5","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.232:2379]}","request-path":"/0/members/20a2700e013b1fa5/attributes","cluster-id":"b7b35e617ebc7ac7","publish-timeout":"7s"} {"level":"info","ts":"2026-05-20T21:27:30.469937Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-20T21:27:30.469961Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-20T21:27:30.470506Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-20T21:27:30.470533Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-20T21:27:30.473045Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.232:2379"} {"level":"info","ts":"2026-05-20T21:27:30.473175Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T21:27:30.474105Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b7b35e617ebc7ac7","local-member-id":"20a2700e013b1fa5","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T21:27:30.474254Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T21:27:30.474314Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T21:27:30.477146Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-20T21:27:33.553603Z","caller":"traceutil/trace.go:171","msg":"trace[14365748] transaction","detail":"{read_only:false; response_revision:165; number_of_response:1; }","duration":"183.068039ms","start":"2026-05-20T21:27:33.370506Z","end":"2026-05-20T21:27:33.553574Z","steps":["trace[14365748] 'process raft request' (duration: 182.895385ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:27:34.270336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.371755ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T21:27:34.270472Z","caller":"traceutil/trace.go:171","msg":"trace[1290430427] linearizableReadLoop","detail":"{readStateIndex:170; appliedIndex:169; }","duration":"412.487013ms","start":"2026-05-20T21:27:33.857959Z","end":"2026-05-20T21:27:34.270446Z","steps":["trace[1290430427] 'read index received' (duration: 23.519042ms)","trace[1290430427] 'applied index is now lower than readState.Index' (duration: 388.966821ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:27:34.270561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.603287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:27:34.270584Z","caller":"traceutil/trace.go:171","msg":"trace[1722887573] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:166; }","duration":"412.669869ms","start":"2026-05-20T21:27:33.857906Z","end":"2026-05-20T21:27:34.270576Z","steps":["trace[1722887573] 'agreement among raft nodes before linearized reading' (duration: 412.592906ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:27:34.270618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:27:33.857882Z","time spent":"412.729221ms","remote":"127.0.0.1:44536","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-05-20T21:27:34.27065Z","caller":"traceutil/trace.go:171","msg":"trace[1262912287] transaction","detail":"{read_only:false; response_revision:166; number_of_response:1; }","duration":"710.614226ms","start":"2026-05-20T21:27:33.560003Z","end":"2026-05-20T21:27:34.270617Z","steps":["trace[1262912287] 'process raft request' (duration: 321.48888ms)","trace[1262912287] 'compare' (duration: 388.235751ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:27:34.270745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:27:33.559977Z","time spent":"710.727408ms","remote":"127.0.0.1:44902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":744,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T21:27:34.708066Z","caller":"traceutil/trace.go:171","msg":"trace[1388543167] transaction","detail":"{read_only:false; response_revision:167; number_of_response:1; }","duration":"430.473442ms","start":"2026-05-20T21:27:34.277559Z","end":"2026-05-20T21:27:34.708032Z","steps":["trace[1388543167] 'process raft request' (duration: 358.789543ms)","trace[1388543167] 'compare' (duration: 71.520404ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:27:34.708221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:27:34.277541Z","time spent":"430.610925ms","remote":"127.0.0.1:44902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":748,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T21:27:35.218821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.797676ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T21:27:35.218976Z","caller":"traceutil/trace.go:171","msg":"trace[2102428815] linearizableReadLoop","detail":"{readStateIndex:173; appliedIndex:171; }","duration":"508.477997ms","start":"2026-05-20T21:27:34.71048Z","end":"2026-05-20T21:27:35.218958Z","steps":["trace[2102428815] 'read index received' (duration: 385.435244ms)","trace[2102428815] 'applied index is now lower than readState.Index' (duration: 123.041793ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:27:35.219136Z","caller":"traceutil/trace.go:171","msg":"trace[273966749] transaction","detail":"{read_only:false; response_revision:168; number_of_response:1; }","duration":"719.307546ms","start":"2026-05-20T21:27:34.499791Z","end":"2026-05-20T21:27:35.219099Z","steps":["trace[273966749] 'process raft request' (duration: 596.16782ms)","trace[273966749] 'compare' (duration: 122.659613ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:27:35.21983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.770417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:27:35.219894Z","caller":"traceutil/trace.go:171","msg":"trace[58095873] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:169; }","duration":"361.903321ms","start":"2026-05-20T21:27:34.857976Z","end":"2026-05-20T21:27:35.21988Z","steps":["trace[58095873] 'agreement among raft nodes before linearized reading' (duration: 361.757767ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:27:35.219929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:27:34.857954Z","time spent":"361.969192ms","remote":"127.0.0.1:44536","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-05-20T21:27:35.219197Z","caller":"traceutil/trace.go:171","msg":"trace[1935663988] transaction","detail":"{read_only:false; response_revision:169; number_of_response:1; }","duration":"601.730114ms","start":"2026-05-20T21:27:34.617459Z","end":"2026-05-20T21:27:35.219189Z","steps":["trace[1935663988] 'process raft request' (duration: 601.446976ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:27:35.220138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:27:34.61743Z","time spent":"602.642189ms","remote":"127.0.0.1:44710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T21:27:35.219373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.860548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:resourcequota-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:27:35.220238Z","caller":"traceutil/trace.go:171","msg":"trace[1818843500] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:resourcequota-controller; range_end:; response_count:0; response_revision:169; }","duration":"509.789915ms","start":"2026-05-20T21:27:34.710435Z","end":"2026-05-20T21:27:35.220225Z","steps":["trace[1818843500] 'agreement among raft nodes before linearized reading' (duration: 508.775256ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:27:35.220275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:27:34.710415Z","time spent":"509.849885ms","remote":"127.0.0.1:44902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":0,"response size":28,"request content":"key:\"/registry/clusterrolebindings/system:controller:resourcequota-controller\" "} {"level":"warn","ts":"2026-05-20T21:27:35.220449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:27:34.499766Z","time spent":"719.958213ms","remote":"127.0.0.1:44710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T21:28:07.885004Z","caller":"traceutil/trace.go:171","msg":"trace[977929460] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"287.384873ms","start":"2026-05-20T21:28:07.597595Z","end":"2026-05-20T21:28:07.88498Z","steps":["trace[977929460] 'process raft request' (duration: 287.24491ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:28:07.891178Z","caller":"traceutil/trace.go:171","msg":"trace[914124420] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"292.003251ms","start":"2026-05-20T21:28:07.599137Z","end":"2026-05-20T21:28:07.89114Z","steps":["trace[914124420] 'process raft request' (duration: 291.714364ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:28:07.891784Z","caller":"traceutil/trace.go:171","msg":"trace[1870798276] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"281.019127ms","start":"2026-05-20T21:28:07.610551Z","end":"2026-05-20T21:28:07.89157Z","steps":["trace[1870798276] 'process raft request' (duration: 280.585555ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:28:07.892163Z","caller":"traceutil/trace.go:171","msg":"trace[915332834] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"291.247641ms","start":"2026-05-20T21:28:07.600898Z","end":"2026-05-20T21:28:07.892146Z","steps":["trace[915332834] 'process raft request' (duration: 290.055018ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:28:07.89257Z","caller":"traceutil/trace.go:171","msg":"trace[406993607] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"287.255819ms","start":"2026-05-20T21:28:07.605291Z","end":"2026-05-20T21:28:07.892547Z","steps":["trace[406993607] 'process raft request' (duration: 285.757188ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:07.893146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.842521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-20T21:28:07.893202Z","caller":"traceutil/trace.go:171","msg":"trace[1115006221] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:536; }","duration":"236.965244ms","start":"2026-05-20T21:28:07.656227Z","end":"2026-05-20T21:28:07.893193Z","steps":["trace[1115006221] 'agreement among raft nodes before linearized reading' (duration: 236.758649ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:28:07.892896Z","caller":"traceutil/trace.go:171","msg":"trace[403966119] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"273.22257ms","start":"2026-05-20T21:28:07.619659Z","end":"2026-05-20T21:28:07.892881Z","steps":["trace[403966119] 'process raft request' (duration: 271.634046ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:28:07.892927Z","caller":"traceutil/trace.go:171","msg":"trace[1130320791] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"281.881401ms","start":"2026-05-20T21:28:07.611039Z","end":"2026-05-20T21:28:07.892921Z","steps":["trace[1130320791] 'process raft request' (duration: 280.130943ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:28:07.892944Z","caller":"traceutil/trace.go:171","msg":"trace[1970858981] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"279.500044ms","start":"2026-05-20T21:28:07.613439Z","end":"2026-05-20T21:28:07.892939Z","steps":["trace[1970858981] 'process raft request' (duration: 277.809467ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:28:07.892834Z","caller":"traceutil/trace.go:171","msg":"trace[1894585489] linearizableReadLoop","detail":"{readStateIndex:555; appliedIndex:545; }","duration":"236.472401ms","start":"2026-05-20T21:28:07.656294Z","end":"2026-05-20T21:28:07.892766Z","steps":["trace[1894585489] 'read index received' (duration: 229.115476ms)","trace[1894585489] 'applied index is now lower than readState.Index' (duration: 7.356015ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:28:07.892968Z","caller":"traceutil/trace.go:171","msg":"trace[1234245748] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"270.171875ms","start":"2026-05-20T21:28:07.622792Z","end":"2026-05-20T21:28:07.892964Z","steps":["trace[1234245748] 'process raft request' (duration: 268.55611ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:28:07.89295Z","caller":"traceutil/trace.go:171","msg":"trace[1768241884] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"253.35955ms","start":"2026-05-20T21:28:07.639547Z","end":"2026-05-20T21:28:07.892906Z","steps":["trace[1768241884] 'process raft request' (duration: 251.963221ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:28:07.893064Z","caller":"traceutil/trace.go:171","msg":"trace[783984706] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"283.738492ms","start":"2026-05-20T21:28:07.60932Z","end":"2026-05-20T21:28:07.893058Z","steps":["trace[783984706] 'process raft request' (duration: 281.771837ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:28:09.358352Z","caller":"traceutil/trace.go:171","msg":"trace[1067872812] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:629; }","duration":"114.439085ms","start":"2026-05-20T21:28:09.24388Z","end":"2026-05-20T21:28:09.358319Z","steps":["trace[1067872812] 'read index received' (duration: 109.55744ms)","trace[1067872812] 'applied index is now lower than readState.Index' (duration: 4.880835ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:28:09.358457Z","caller":"traceutil/trace.go:171","msg":"trace[5974339] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"117.51808ms","start":"2026-05-20T21:28:09.240931Z","end":"2026-05-20T21:28:09.358449Z","steps":["trace[5974339] 'process raft request' (duration: 112.569702ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:09.358747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.839516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"info","ts":"2026-05-20T21:28:09.358773Z","caller":"traceutil/trace.go:171","msg":"trace[1816524976] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:603; }","duration":"114.941848ms","start":"2026-05-20T21:28:09.243823Z","end":"2026-05-20T21:28:09.358765Z","steps":["trace[1816524976] 'agreement among raft nodes before linearized reading' (duration: 114.814285ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:28:09.55717Z","caller":"traceutil/trace.go:171","msg":"trace[842230934] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:630; }","duration":"149.376984ms","start":"2026-05-20T21:28:09.407751Z","end":"2026-05-20T21:28:09.557128Z","steps":["trace[842230934] 'read index received' (duration: 121.803669ms)","trace[842230934] 'applied index is now lower than readState.Index' (duration: 27.571545ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:28:09.557355Z","caller":"traceutil/trace.go:171","msg":"trace[1531319245] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"150.225538ms","start":"2026-05-20T21:28:09.407074Z","end":"2026-05-20T21:28:09.557299Z","steps":["trace[1531319245] 'process raft request' (duration: 122.716905ms)","trace[1531319245] 'compare' (duration: 27.020419ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:28:09.557667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.896439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xlistenersets.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:29476"} {"level":"info","ts":"2026-05-20T21:28:09.557772Z","caller":"traceutil/trace.go:171","msg":"trace[1043714550] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/xlistenersets.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:604; }","duration":"150.071925ms","start":"2026-05-20T21:28:09.407675Z","end":"2026-05-20T21:28:09.557747Z","steps":["trace[1043714550] 'agreement among raft nodes before linearized reading' (duration: 149.662843ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.2706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.484067ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-20T21:28:11.27075Z","caller":"traceutil/trace.go:171","msg":"trace[1188743148] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:635; }","duration":"726.766404ms","start":"2026-05-20T21:28:10.54396Z","end":"2026-05-20T21:28:11.270726Z","steps":["trace[1188743148] 'read index received' (duration: 289.036389ms)","trace[1188743148] 'applied index is now lower than readState.Index' (duration: 437.728115ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:28:11.270825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"726.842375ms","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-05-20T21:28:11.270895Z","caller":"traceutil/trace.go:171","msg":"trace[1313328796] 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:608; }","duration":"726.973639ms","start":"2026-05-20T21:28:10.543908Z","end":"2026-05-20T21:28:11.270881Z","steps":["trace[1313328796] 'agreement among raft nodes before linearized reading' (duration: 726.854846ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.270931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:10.54388Z","time spent":"727.043752ms","remote":"127.0.0.1:37520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-05-20T21:28:11.271152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.127056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:28:11.271181Z","caller":"traceutil/trace.go:171","msg":"trace[226285286] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:608; }","duration":"562.170817ms","start":"2026-05-20T21:28:10.709002Z","end":"2026-05-20T21:28:11.271173Z","steps":["trace[226285286] 'agreement among raft nodes before linearized reading' (duration: 562.121275ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.271172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.042691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T21:28:11.271209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:10.708996Z","time spent":"562.205658ms","remote":"127.0.0.1:37530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"info","ts":"2026-05-20T21:28:11.271226Z","caller":"traceutil/trace.go:171","msg":"trace[1000058518] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:608; }","duration":"510.118073ms","start":"2026-05-20T21:28:10.761093Z","end":"2026-05-20T21:28:11.271211Z","steps":["trace[1000058518] 'agreement among raft nodes before linearized reading' (duration: 510.03507ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.271225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.253753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T21:28:11.271374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.530072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:28:11.2714Z","caller":"traceutil/trace.go:171","msg":"trace[366826536] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:608; }","duration":"538.563912ms","start":"2026-05-20T21:28:10.732829Z","end":"2026-05-20T21:28:11.271393Z","steps":["trace[366826536] 'agreement among raft nodes before linearized reading' (duration: 538.527981ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.271424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:10.732825Z","time spent":"538.593133ms","remote":"127.0.0.1:37534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-20T21:28:11.271498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:10.761082Z","time spent":"510.397732ms","remote":"127.0.0.1:37550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 "} {"level":"info","ts":"2026-05-20T21:28:11.27148Z","caller":"traceutil/trace.go:171","msg":"trace[1630468450] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:608; }","duration":"259.52407ms","start":"2026-05-20T21:28:11.011849Z","end":"2026-05-20T21:28:11.271373Z","steps":["trace[1630468450] 'agreement among raft nodes before linearized reading' (duration: 259.233632ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.271715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.20863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:28:11.271747Z","caller":"traceutil/trace.go:171","msg":"trace[1327709043] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:608; }","duration":"437.276882ms","start":"2026-05-20T21:28:10.834463Z","end":"2026-05-20T21:28:11.27174Z","steps":["trace[1327709043] 'agreement among raft nodes before linearized reading' (duration: 437.20787ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.271742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.592015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T21:28:11.271823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.284813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:28:11.271842Z","caller":"traceutil/trace.go:171","msg":"trace[146669259] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:608; }","duration":"437.316784ms","start":"2026-05-20T21:28:10.83452Z","end":"2026-05-20T21:28:11.271837Z","steps":["trace[146669259] 'agreement among raft nodes before linearized reading' (duration: 437.286853ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.271866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:10.834515Z","time spent":"437.345394ms","remote":"127.0.0.1:37566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-05-20T21:28:11.271926Z","caller":"traceutil/trace.go:171","msg":"trace[944450603] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:608; }","duration":"422.730679ms","start":"2026-05-20T21:28:10.849103Z","end":"2026-05-20T21:28:11.271834Z","steps":["trace[944450603] 'agreement among raft nodes before linearized reading' (duration: 422.602805ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.271962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:10.849084Z","time spent":"422.869343ms","remote":"127.0.0.1:37576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-20T21:28:11.27211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.629106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T21:28:11.272126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.354435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T21:28:11.272116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.7496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:28:11.272141Z","caller":"traceutil/trace.go:171","msg":"trace[1025546342] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:608; }","duration":"510.878254ms","start":"2026-05-20T21:28:10.761254Z","end":"2026-05-20T21:28:11.272132Z","steps":["trace[1025546342] 'agreement among raft nodes before linearized reading' (duration: 510.832572ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:28:11.272148Z","caller":"traceutil/trace.go:171","msg":"trace[1811472245] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:608; }","duration":"410.377546ms","start":"2026-05-20T21:28:10.861764Z","end":"2026-05-20T21:28:11.272141Z","steps":["trace[1811472245] 'agreement among raft nodes before linearized reading' (duration: 410.341695ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.272164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:10.761246Z","time spent":"510.911606ms","remote":"127.0.0.1:37550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 "} {"level":"info","ts":"2026-05-20T21:28:11.27216Z","caller":"traceutil/trace.go:171","msg":"trace[2030587928] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:608; }","duration":"470.836553ms","start":"2026-05-20T21:28:10.801312Z","end":"2026-05-20T21:28:11.272149Z","steps":["trace[2030587928] 'agreement among raft nodes before linearized reading' (duration: 470.760681ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.272203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:10.801288Z","time spent":"470.901394ms","remote":"127.0.0.1:37562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-05-20T21:28:11.272266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.360197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:28:11.272291Z","caller":"traceutil/trace.go:171","msg":"trace[1444719936] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:608; }","duration":"471.385108ms","start":"2026-05-20T21:28:10.8009Z","end":"2026-05-20T21:28:11.272285Z","steps":["trace[1444719936] 'agreement among raft nodes before linearized reading' (duration: 471.349697ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.272311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:10.80075Z","time spent":"471.555762ms","remote":"127.0.0.1:37562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-20T21:28:11.272401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:10.861706Z","time spent":"410.54807ms","remote":"127.0.0.1:37576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-20T21:28:11.272534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.328605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T21:28:11.272545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.455976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:28:11.272562Z","caller":"traceutil/trace.go:171","msg":"trace[381530253] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:608; }","duration":"423.358027ms","start":"2026-05-20T21:28:10.849197Z","end":"2026-05-20T21:28:11.272555Z","steps":["trace[381530253] 'agreement among raft nodes before linearized reading' (duration: 423.314905ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:28:11.272566Z","caller":"traceutil/trace.go:171","msg":"trace[1179530766] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:608; }","duration":"136.477327ms","start":"2026-05-20T21:28:11.136082Z","end":"2026-05-20T21:28:11.272559Z","steps":["trace[1179530766] 'agreement among raft nodes before linearized reading' (duration: 136.445565ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.272583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:10.849181Z","time spent":"423.396427ms","remote":"127.0.0.1:37576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-20T21:28:11.271768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:10.834439Z","time spent":"437.324263ms","remote":"127.0.0.1:37566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-20T21:28:11.272412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.822932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:28:11.27284Z","caller":"traceutil/trace.go:171","msg":"trace[945848690] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:608; }","duration":"511.264745ms","start":"2026-05-20T21:28:10.761566Z","end":"2026-05-20T21:28:11.272831Z","steps":["trace[945848690] 'agreement among raft nodes before linearized reading' (duration: 510.827943ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.272894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:10.76156Z","time spent":"511.324307ms","remote":"127.0.0.1:37550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-05-20T21:28:11.271795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.118361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:28:11.273041Z","caller":"traceutil/trace.go:171","msg":"trace[1206376603] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:608; }","duration":"432.401257ms","start":"2026-05-20T21:28:10.840631Z","end":"2026-05-20T21:28:11.273032Z","steps":["trace[1206376603] 'agreement among raft nodes before linearized reading' (duration: 431.149672ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.273144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:10.840598Z","time spent":"432.534861ms","remote":"127.0.0.1:37566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-05-20T21:28:11.273161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.21932ms","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-05-20T21:28:11.273185Z","caller":"traceutil/trace.go:171","msg":"trace[1872910180] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:608; }","duration":"136.28528ms","start":"2026-05-20T21:28:11.13689Z","end":"2026-05-20T21:28:11.273176Z","steps":["trace[1872910180] 'agreement among raft nodes before linearized reading' (duration: 136.2537ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.273428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.257638ms","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-05-20T21:28:11.273567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.431763ms","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-05-20T21:28:11.273598Z","caller":"traceutil/trace.go:171","msg":"trace[1845603850] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:608; }","duration":"137.489345ms","start":"2026-05-20T21:28:11.136102Z","end":"2026-05-20T21:28:11.273591Z","steps":["trace[1845603850] 'agreement among raft nodes before linearized reading' (duration: 137.423704ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.274254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"701.093321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:28:11.274289Z","caller":"traceutil/trace.go:171","msg":"trace[1959935698] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:608; }","duration":"701.138663ms","start":"2026-05-20T21:28:10.573141Z","end":"2026-05-20T21:28:11.274279Z","steps":["trace[1959935698] 'agreement among raft nodes before linearized reading' (duration: 701.091121ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.274309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:10.573136Z","time spent":"701.167344ms","remote":"127.0.0.1:37526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"warn","ts":"2026-05-20T21:28:11.274571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.586262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:28:11.274599Z","caller":"traceutil/trace.go:171","msg":"trace[1773422926] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:608; }","duration":"565.653014ms","start":"2026-05-20T21:28:10.70894Z","end":"2026-05-20T21:28:11.274593Z","steps":["trace[1773422926] 'agreement among raft nodes before linearized reading' (duration: 565.611583ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.274618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:10.708913Z","time spent":"565.700386ms","remote":"127.0.0.1:37530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-05-20T21:28:11.275148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.868616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:28:11.275177Z","caller":"traceutil/trace.go:171","msg":"trace[642278505] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:608; }","duration":"700.911647ms","start":"2026-05-20T21:28:10.574258Z","end":"2026-05-20T21:28:11.27517Z","steps":["trace[642278505] 'agreement among raft nodes before linearized reading' (duration: 700.838605ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.275197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:10.574239Z","time spent":"700.952848ms","remote":"127.0.0.1:37526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"warn","ts":"2026-05-20T21:28:11.271524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.746338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T21:28:11.276032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.050416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:28:11.275952Z","caller":"traceutil/trace.go:171","msg":"trace[1487917059] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:608; }","duration":"543.191641ms","start":"2026-05-20T21:28:10.732742Z","end":"2026-05-20T21:28:11.275934Z","steps":["trace[1487917059] 'agreement among raft nodes before linearized reading' (duration: 538.764688ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:28:11.276063Z","caller":"traceutil/trace.go:171","msg":"trace[510756617] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:608; }","duration":"703.106838ms","start":"2026-05-20T21:28:10.572949Z","end":"2026-05-20T21:28:11.276056Z","steps":["trace[510756617] 'agreement among raft nodes before linearized reading' (duration: 703.059417ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.276154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:10.732726Z","time spent":"543.384467ms","remote":"127.0.0.1:37534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-20T21:28:11.276162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:10.572935Z","time spent":"703.2183ms","remote":"127.0.0.1:37526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-05-20T21:28:11.276655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"732.39666ms","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-05-20T21:28:11.276683Z","caller":"traceutil/trace.go:171","msg":"trace[551855843] 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:608; }","duration":"732.440401ms","start":"2026-05-20T21:28:10.544237Z","end":"2026-05-20T21:28:11.276677Z","steps":["trace[551855843] 'agreement among raft nodes before linearized reading' (duration: 732.398129ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.276703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:10.544213Z","time spent":"732.484731ms","remote":"127.0.0.1:37520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-05-20T21:28:11.27708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.066234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:28:11.277113Z","caller":"traceutil/trace.go:171","msg":"trace[723525216] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:608; }","duration":"265.163537ms","start":"2026-05-20T21:28:11.011942Z","end":"2026-05-20T21:28:11.277105Z","steps":["trace[723525216] 'agreement among raft nodes before linearized reading' (duration: 265.107855ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.271554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.237718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T21:28:11.271342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.826582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T21:28:11.277496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.335513ms","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-05-20T21:28:11.277672Z","caller":"traceutil/trace.go:171","msg":"trace[1111848237] 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:608; }","duration":"242.530949ms","start":"2026-05-20T21:28:11.035112Z","end":"2026-05-20T21:28:11.277643Z","steps":["trace[1111848237] 'agreement among raft nodes before linearized reading' (duration: 242.341893ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.277814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.773166ms","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-05-20T21:28:11.277836Z","caller":"traceutil/trace.go:171","msg":"trace[966955619] 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:608; }","duration":"242.825237ms","start":"2026-05-20T21:28:11.035006Z","end":"2026-05-20T21:28:11.277831Z","steps":["trace[966955619] 'agreement among raft nodes before linearized reading' (duration: 242.784006ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:28:11.278065Z","caller":"traceutil/trace.go:171","msg":"trace[50392516] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:608; }","duration":"544.558819ms","start":"2026-05-20T21:28:10.733499Z","end":"2026-05-20T21:28:11.278058Z","steps":["trace[50392516] 'agreement among raft nodes before linearized reading' (duration: 537.821242ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.278103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:10.733493Z","time spent":"544.59956ms","remote":"127.0.0.1:37534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"warn","ts":"2026-05-20T21:28:11.278145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.422023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:28:11.27817Z","caller":"traceutil/trace.go:171","msg":"trace[343417910] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:608; }","duration":"265.472075ms","start":"2026-05-20T21:28:11.012692Z","end":"2026-05-20T21:28:11.278164Z","steps":["trace[343417910] 'agreement among raft nodes before linearized reading' (duration: 265.228888ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.277543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.439475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:28:11.278294Z","caller":"traceutil/trace.go:171","msg":"trace[2020795066] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:608; }","duration":"569.041778ms","start":"2026-05-20T21:28:10.709245Z","end":"2026-05-20T21:28:11.278287Z","steps":["trace[2020795066] 'agreement among raft nodes before linearized reading' (duration: 562.29235ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:28:11.278267Z","caller":"traceutil/trace.go:171","msg":"trace[111801612] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:608; }","duration":"195.180106ms","start":"2026-05-20T21:28:11.083081Z","end":"2026-05-20T21:28:11.278261Z","steps":["trace[111801612] 'agreement among raft nodes before linearized reading' (duration: 194.446786ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.278451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:10.709225Z","time spent":"569.173922ms","remote":"127.0.0.1:37530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"warn","ts":"2026-05-20T21:28:11.277595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.010915ms","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-05-20T21:28:11.278913Z","caller":"traceutil/trace.go:171","msg":"trace[110634202] 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:608; }","duration":"243.326741ms","start":"2026-05-20T21:28:11.035576Z","end":"2026-05-20T21:28:11.278903Z","steps":["trace[110634202] 'agreement among raft nodes before linearized reading' (duration: 241.978674ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:28:11.273483Z","caller":"traceutil/trace.go:171","msg":"trace[1660862764] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:608; }","duration":"190.339141ms","start":"2026-05-20T21:28:11.083132Z","end":"2026-05-20T21:28:11.273471Z","steps":["trace[1660862764] 'agreement among raft nodes before linearized reading' (duration: 190.252018ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.280563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"726.98001ms","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-05-20T21:28:11.28082Z","caller":"traceutil/trace.go:171","msg":"trace[617106715] 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:608; }","duration":"736.7515ms","start":"2026-05-20T21:28:10.544057Z","end":"2026-05-20T21:28:11.280809Z","steps":["trace[617106715] 'agreement among raft nodes before linearized reading' (duration: 726.887057ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:11.281442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:10.544051Z","time spent":"737.379157ms","remote":"127.0.0.1:37520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"info","ts":"2026-05-20T21:28:14.901553Z","caller":"traceutil/trace.go:171","msg":"trace[1342777931] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"264.273036ms","start":"2026-05-20T21:28:14.637251Z","end":"2026-05-20T21:28:14.901524Z","steps":["trace[1342777931] 'process raft request' (duration: 264.094581ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:15.748608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.233928ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:28:15.748798Z","caller":"traceutil/trace.go:171","msg":"trace[1415492292] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:635; }","duration":"530.429992ms","start":"2026-05-20T21:28:15.218334Z","end":"2026-05-20T21:28:15.748764Z","steps":["trace[1415492292] 'range keys from in-memory index tree' (duration: 530.214166ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:15.783321Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2280402815343506791,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-20T21:28:15.86268Z","caller":"traceutil/trace.go:171","msg":"trace[990840449] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:663; }","duration":"580.160112ms","start":"2026-05-20T21:28:15.282464Z","end":"2026-05-20T21:28:15.862625Z","steps":["trace[990840449] 'read index received' (duration: 575.024661ms)","trace[990840449] 'applied index is now lower than readState.Index' (duration: 5.134471ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:28:15.862955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.4717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:28:15.863117Z","caller":"traceutil/trace.go:171","msg":"trace[1022545215] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"580.689127ms","start":"2026-05-20T21:28:15.282416Z","end":"2026-05-20T21:28:15.863105Z","steps":["trace[1022545215] 'agreement among raft nodes before linearized reading' (duration: 580.4355ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:15.86317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:15.282398Z","time spent":"580.764329ms","remote":"127.0.0.1:44536","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-05-20T21:28:15.863062Z","caller":"traceutil/trace.go:171","msg":"trace[1383789140] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"1.046073401s","start":"2026-05-20T21:28:14.816964Z","end":"2026-05-20T21:28:15.863038Z","steps":["trace[1383789140] 'process raft request' (duration: 1.040780646s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:15.863258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.751382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.232\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-20T21:28:15.863367Z","caller":"traceutil/trace.go:171","msg":"trace[286020092] range","detail":"{range_begin:/registry/masterleases/199.19.213.232; range_end:; response_count:1; response_revision:636; }","duration":"402.913196ms","start":"2026-05-20T21:28:15.460431Z","end":"2026-05-20T21:28:15.863344Z","steps":["trace[286020092] 'agreement among raft nodes before linearized reading' (duration: 402.67866ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:15.863426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:15.460406Z","time spent":"403.006658ms","remote":"127.0.0.1:44570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.232\" "} {"level":"warn","ts":"2026-05-20T21:28:15.863506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:14.81693Z","time spent":"1.046286127s","remote":"127.0.0.1:44620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:28:16.63057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"666.707919ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T21:28:16.630787Z","caller":"traceutil/trace.go:171","msg":"trace[55897788] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:666; }","duration":"667.023247ms","start":"2026-05-20T21:28:15.96375Z","end":"2026-05-20T21:28:16.630774Z","steps":["trace[55897788] 'read index received' (duration: 41.951µs)","trace[55897788] 'applied index is now lower than readState.Index' (duration: 666.980316ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:28:16.630882Z","caller":"traceutil/trace.go:171","msg":"trace[326708412] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"703.572537ms","start":"2026-05-20T21:28:15.92729Z","end":"2026-05-20T21:28:16.630862Z","steps":["trace[326708412] 'process raft request' (duration: 36.458707ms)","trace[326708412] 'compare' (duration: 666.569635ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:28:16.631054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:15.927251Z","time spent":"703.786153ms","remote":"127.0.0.1:45066","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T21:28:16.631131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.350246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-20T21:28:16.631238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.355287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-20T21:28:16.631274Z","caller":"traceutil/trace.go:171","msg":"trace[1981153417] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:638; }","duration":"667.518642ms","start":"2026-05-20T21:28:15.963715Z","end":"2026-05-20T21:28:16.631233Z","steps":["trace[1981153417] 'agreement among raft nodes before linearized reading' (duration: 667.199734ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:28:16.631309Z","caller":"traceutil/trace.go:171","msg":"trace[636537624] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:638; }","duration":"599.489921ms","start":"2026-05-20T21:28:16.031802Z","end":"2026-05-20T21:28:16.631292Z","steps":["trace[636537624] 'agreement among raft nodes before linearized reading' (duration: 599.356018ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:16.631341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:16.031772Z","time spent":"599.564273ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-20T21:28:16.6314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:15.963697Z","time spent":"667.672766ms","remote":"127.0.0.1:44802","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":"warn","ts":"2026-05-20T21:28:16.631478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.129081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-20T21:28:16.631497Z","caller":"traceutil/trace.go:171","msg":"trace[1105572217] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:638; }","duration":"381.185043ms","start":"2026-05-20T21:28:16.250307Z","end":"2026-05-20T21:28:16.631492Z","steps":["trace[1105572217] 'agreement among raft nodes before linearized reading' (duration: 381.146062ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:16.631523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:16.250285Z","time spent":"381.233323ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-20T21:28:16.631594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.228293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-20T21:28:16.631652Z","caller":"traceutil/trace.go:171","msg":"trace[397960712] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:638; }","duration":"381.299145ms","start":"2026-05-20T21:28:16.250339Z","end":"2026-05-20T21:28:16.631638Z","steps":["trace[397960712] 'agreement among raft nodes before linearized reading' (duration: 381.169791ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:16.631679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:16.250281Z","time spent":"381.393688ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-20T21:28:17.005853Z","caller":"traceutil/trace.go:171","msg":"trace[775185154] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"371.192339ms","start":"2026-05-20T21:28:16.634637Z","end":"2026-05-20T21:28:17.005829Z","steps":["trace[775185154] 'process raft request' (duration: 370.952042ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:17.00609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:16.634615Z","time spent":"371.390194ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:28:17.006329Z","caller":"traceutil/trace.go:171","msg":"trace[831858216] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"371.663741ms","start":"2026-05-20T21:28:16.634642Z","end":"2026-05-20T21:28:17.006306Z","steps":["trace[831858216] 'process raft request' (duration: 371.151527ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:17.006375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.621611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:28:17.006432Z","caller":"traceutil/trace.go:171","msg":"trace[277446270] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:642; }","duration":"367.710993ms","start":"2026-05-20T21:28:16.638703Z","end":"2026-05-20T21:28:17.006413Z","steps":["trace[277446270] 'agreement among raft nodes before linearized reading' (duration: 367.624321ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:17.006487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:16.638687Z","time spent":"367.786475ms","remote":"127.0.0.1:44770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-05-20T21:28:17.006492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:16.634614Z","time spent":"371.784375ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:28:17.006511Z","caller":"traceutil/trace.go:171","msg":"trace[675900415] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"371.706703ms","start":"2026-05-20T21:28:16.634779Z","end":"2026-05-20T21:28:17.006486Z","steps":["trace[675900415] 'process raft request' (duration: 371.375274ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:28:17.005866Z","caller":"traceutil/trace.go:171","msg":"trace[882037428] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"371.198239ms","start":"2026-05-20T21:28:16.634626Z","end":"2026-05-20T21:28:17.005824Z","steps":["trace[882037428] 'process raft request' (duration: 331.797722ms)","trace[882037428] 'compare' (duration: 38.470922ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:28:17.006649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:16.634768Z","time spent":"371.811346ms","remote":"127.0.0.1:44802","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-05-20T21:28:17.006739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:16.634608Z","time spent":"372.049883ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:28:17.006246Z","caller":"traceutil/trace.go:171","msg":"trace[805314972] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:667; }","duration":"367.484087ms","start":"2026-05-20T21:28:16.638741Z","end":"2026-05-20T21:28:17.006225Z","steps":["trace[805314972] 'read index received' (duration: 327.693429ms)","trace[805314972] 'applied index is now lower than readState.Index' (duration: 39.789368ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:28:32.525348Z","caller":"traceutil/trace.go:171","msg":"trace[1904953761] linearizableReadLoop","detail":"{readStateIndex:829; appliedIndex:828; }","duration":"108.691851ms","start":"2026-05-20T21:28:32.416637Z","end":"2026-05-20T21:28:32.525329Z","steps":["trace[1904953761] 'read index received' (duration: 108.535977ms)","trace[1904953761] 'applied index is now lower than readState.Index' (duration: 155.154µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:28:32.525424Z","caller":"traceutil/trace.go:171","msg":"trace[1688999563] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"158.636127ms","start":"2026-05-20T21:28:32.366761Z","end":"2026-05-20T21:28:32.525397Z","steps":["trace[1688999563] 'process raft request' (duration: 158.442012ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:32.525723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.063173ms","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-05-20T21:28:32.525774Z","caller":"traceutil/trace.go:171","msg":"trace[1251640906] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:796; }","duration":"109.156494ms","start":"2026-05-20T21:28:32.416606Z","end":"2026-05-20T21:28:32.525762Z","steps":["trace[1251640906] 'agreement among raft nodes before linearized reading' (duration: 108.808034ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:28:32.692255Z","caller":"traceutil/trace.go:171","msg":"trace[918920897] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"159.566903ms","start":"2026-05-20T21:28:32.532664Z","end":"2026-05-20T21:28:32.692231Z","steps":["trace[918920897] 'process raft request' (duration: 159.44289ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:33.712666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"627.61791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-20T21:28:33.712748Z","caller":"traceutil/trace.go:171","msg":"trace[526850273] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:801; }","duration":"627.800026ms","start":"2026-05-20T21:28:33.084929Z","end":"2026-05-20T21:28:33.712729Z","steps":["trace[526850273] 'range keys from in-memory index tree' (duration: 627.359382ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:33.712743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.499422ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"warn","ts":"2026-05-20T21:28:33.712791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:33.084903Z","time spent":"627.878147ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-20T21:28:33.712848Z","caller":"traceutil/trace.go:171","msg":"trace[999535568] linearizableReadLoop","detail":"{readStateIndex:835; appliedIndex:834; }","duration":"604.869879ms","start":"2026-05-20T21:28:33.10796Z","end":"2026-05-20T21:28:33.71283Z","steps":["trace[999535568] 'read index received' (duration: 419.177321ms)","trace[999535568] 'applied index is now lower than readState.Index' (duration: 185.691108ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:28:33.713015Z","caller":"traceutil/trace.go:171","msg":"trace[1273062010] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"624.449523ms","start":"2026-05-20T21:28:33.088546Z","end":"2026-05-20T21:28:33.712996Z","steps":["trace[1273062010] 'process raft request' (duration: 438.587521ms)","trace[1273062010] 'compare' (duration: 185.383219ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:28:33.713104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:33.088504Z","time spent":"624.557447ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:28:33.713425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.157811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-20T21:28:33.713486Z","caller":"traceutil/trace.go:171","msg":"trace[116082962] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:802; }","duration":"603.253854ms","start":"2026-05-20T21:28:33.110216Z","end":"2026-05-20T21:28:33.71347Z","steps":["trace[116082962] 'agreement among raft nodes before linearized reading' (duration: 603.026427ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:33.713531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:33.110203Z","time spent":"603.317375ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-20T21:28:33.713706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.754913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-20T21:28:33.713744Z","caller":"traceutil/trace.go:171","msg":"trace[413205838] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:802; }","duration":"605.835024ms","start":"2026-05-20T21:28:33.107899Z","end":"2026-05-20T21:28:33.713734Z","steps":["trace[413205838] 'agreement among raft nodes before linearized reading' (duration: 605.717071ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:33.713774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:33.10788Z","time spent":"605.885676ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-20T21:28:33.713857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.430298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-20T21:28:33.7139Z","caller":"traceutil/trace.go:171","msg":"trace[1893777579] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:802; }","duration":"603.519091ms","start":"2026-05-20T21:28:33.110368Z","end":"2026-05-20T21:28:33.713887Z","steps":["trace[1893777579] 'agreement among raft nodes before linearized reading' (duration: 603.412788ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:28:33.713938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:28:33.110342Z","time spent":"603.587094ms","remote":"127.0.0.1:44802","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-05-20T21:29:08.33675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.362364ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T21:29:08.336882Z","caller":"traceutil/trace.go:171","msg":"trace[1980542716] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"398.516855ms","start":"2026-05-20T21:29:07.938348Z","end":"2026-05-20T21:29:08.336865Z","steps":["trace[1980542716] 'process raft request' (duration: 45.948155ms)","trace[1980542716] 'compare' (duration: 352.246581ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:29:08.336935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:29:07.938298Z","time spent":"398.611058ms","remote":"127.0.0.1:44802","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-05-20T21:29:09.240182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.000403ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T21:29:09.240433Z","caller":"traceutil/trace.go:171","msg":"trace[482666560] linearizableReadLoop","detail":"{readStateIndex:1058; appliedIndex:1056; }","duration":"958.734613ms","start":"2026-05-20T21:29:08.28167Z","end":"2026-05-20T21:29:09.240405Z","steps":["trace[482666560] 'read index received' (duration: 432.381581ms)","trace[482666560] 'applied index is now lower than readState.Index' (duration: 526.352102ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:29:09.240505Z","caller":"traceutil/trace.go:171","msg":"trace[1424167937] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"1.30205111s","start":"2026-05-20T21:29:07.938442Z","end":"2026-05-20T21:29:09.240493Z","steps":["trace[1424167937] 'process raft request' (duration: 775.621407ms)","trace[1424167937] 'compare' (duration: 525.465077ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:29:09.240499Z","caller":"traceutil/trace.go:171","msg":"trace[1367560159] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"905.639161ms","start":"2026-05-20T21:29:08.33483Z","end":"2026-05-20T21:29:09.24047Z","steps":["trace[1367560159] 'process raft request' (duration: 905.542159ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:29:09.240561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:29:07.938384Z","time spent":"1.302146002s","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:29:09.240644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:29:08.334811Z","time spent":"905.753104ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:29:09.240783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"959.099383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:29:09.240852Z","caller":"traceutil/trace.go:171","msg":"trace[630617874] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1017; }","duration":"959.213576ms","start":"2026-05-20T21:29:08.281619Z","end":"2026-05-20T21:29:09.240833Z","steps":["trace[630617874] 'agreement among raft nodes before linearized reading' (duration: 959.075852ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:29:09.24089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:29:08.281596Z","time spent":"959.288038ms","remote":"127.0.0.1:44548","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-05-20T21:29:09.24093Z","caller":"traceutil/trace.go:171","msg":"trace[442129397] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"1.302123711s","start":"2026-05-20T21:29:07.938796Z","end":"2026-05-20T21:29:09.240919Z","steps":["trace[442129397] 'process raft request' (duration: 1.301482614s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:29:09.240987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:29:07.938785Z","time spent":"1.302173462s","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:29:09.504248Z","caller":"traceutil/trace.go:171","msg":"trace[1342141322] linearizableReadLoop","detail":"{readStateIndex:1060; appliedIndex:1059; }","duration":"263.757902ms","start":"2026-05-20T21:29:09.240461Z","end":"2026-05-20T21:29:09.504219Z","steps":["trace[1342141322] 'read index received' (duration: 261.627924ms)","trace[1342141322] 'applied index is now lower than readState.Index' (duration: 2.128717ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:29:09.504281Z","caller":"traceutil/trace.go:171","msg":"trace[837155496] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"300.541287ms","start":"2026-05-20T21:29:09.203689Z","end":"2026-05-20T21:29:09.50423Z","steps":["trace[837155496] 'process raft request' (duration: 298.391858ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:29:09.504425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.638176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T21:29:09.504621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:29:09.203671Z","time spent":"300.696331ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:29:09.504643Z","caller":"traceutil/trace.go:171","msg":"trace[294225779] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1018; }","duration":"222.916104ms","start":"2026-05-20T21:29:09.281716Z","end":"2026-05-20T21:29:09.504632Z","steps":["trace[294225779] 'agreement among raft nodes before linearized reading' (duration: 222.651818ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:29:09.504627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.968438ms","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-05-20T21:29:09.504703Z","caller":"traceutil/trace.go:171","msg":"trace[1402998559] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1018; }","duration":"658.286968ms","start":"2026-05-20T21:29:08.846398Z","end":"2026-05-20T21:29:09.504685Z","steps":["trace[1402998559] 'agreement among raft nodes before linearized reading' (duration: 657.858107ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:29:09.504742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:29:08.846375Z","time spent":"658.35908ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-20T21:29:09.504634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.034735551s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-20T21:29:09.504786Z","caller":"traceutil/trace.go:171","msg":"trace[1187533173] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1018; }","duration":"1.035125561s","start":"2026-05-20T21:29:08.469647Z","end":"2026-05-20T21:29:09.504772Z","steps":["trace[1187533173] 'agreement among raft nodes before linearized reading' (duration: 1.034654477s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:29:09.50482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:29:08.469626Z","time spent":"1.035185793s","remote":"127.0.0.1:45068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":112,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-05-20T21:29:31.436137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.439631ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-20T21:29:31.436267Z","caller":"traceutil/trace.go:171","msg":"trace[1748088241] linearizableReadLoop","detail":"{readStateIndex:1134; appliedIndex:1133; }","duration":"159.817718ms","start":"2026-05-20T21:29:31.27643Z","end":"2026-05-20T21:29:31.436248Z","steps":["trace[1748088241] 'read index received' (duration: 59.432µs)","trace[1748088241] 'applied index is now lower than readState.Index' (duration: 159.756516ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:29:31.436613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.178657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:29:31.436662Z","caller":"traceutil/trace.go:171","msg":"trace[1371431123] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1087; }","duration":"160.298481ms","start":"2026-05-20T21:29:31.276352Z","end":"2026-05-20T21:29:31.43665Z","steps":["trace[1371431123] 'agreement among raft nodes before linearized reading' (duration: 160.200648ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:29:31.43685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.741668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:29:31.437004Z","caller":"traceutil/trace.go:171","msg":"trace[327906662] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1087; }","duration":"154.973056ms","start":"2026-05-20T21:29:31.282007Z","end":"2026-05-20T21:29:31.43698Z","steps":["trace[327906662] 'agreement among raft nodes before linearized reading' (duration: 154.673437ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:29:32.897712Z","caller":"traceutil/trace.go:171","msg":"trace[2056957592] linearizableReadLoop","detail":"{readStateIndex:1140; appliedIndex:1139; }","duration":"215.678009ms","start":"2026-05-20T21:29:32.682011Z","end":"2026-05-20T21:29:32.897689Z","steps":["trace[2056957592] 'read index received' (duration: 215.523804ms)","trace[2056957592] 'applied index is now lower than readState.Index' (duration: 153.065µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:29:32.897803Z","caller":"traceutil/trace.go:171","msg":"trace[256953429] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"390.461185ms","start":"2026-05-20T21:29:32.507312Z","end":"2026-05-20T21:29:32.897773Z","steps":["trace[256953429] 'process raft request' (duration: 390.245779ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:29:32.897832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.818352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-20T21:29:32.89791Z","caller":"traceutil/trace.go:171","msg":"trace[1469275205] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1093; }","duration":"215.974065ms","start":"2026-05-20T21:29:32.681927Z","end":"2026-05-20T21:29:32.897901Z","steps":["trace[1469275205] 'agreement among raft nodes before linearized reading' (duration: 215.853892ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:29:32.897998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:29:32.507287Z","time spent":"390.624212ms","remote":"127.0.0.1:44802","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-05-20T21:29:50.17295Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2280402815343508019,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-20T21:29:50.260352Z","caller":"traceutil/trace.go:171","msg":"trace[474462396] linearizableReadLoop","detail":"{readStateIndex:1250; appliedIndex:1249; }","duration":"587.857663ms","start":"2026-05-20T21:29:49.672473Z","end":"2026-05-20T21:29:50.26033Z","steps":["trace[474462396] 'read index received' (duration: 587.73324ms)","trace[474462396] 'applied index is now lower than readState.Index' (duration: 123.513µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:29:50.260603Z","caller":"traceutil/trace.go:171","msg":"trace[1248853608] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"737.817992ms","start":"2026-05-20T21:29:49.522773Z","end":"2026-05-20T21:29:50.260591Z","steps":["trace[1248853608] 'process raft request' (duration: 737.432921ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:29:50.260716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:29:49.522752Z","time spent":"737.879543ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:29:50.260926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.512554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-20T21:29:50.260973Z","caller":"traceutil/trace.go:171","msg":"trace[2083972643] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1198; }","duration":"587.579306ms","start":"2026-05-20T21:29:49.673382Z","end":"2026-05-20T21:29:50.260961Z","steps":["trace[2083972643] 'agreement among raft nodes before linearized reading' (duration: 587.436563ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:29:50.261005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:29:49.67337Z","time spent":"587.628497ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-20T21:29:50.261129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.656545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-20T21:29:50.261156Z","caller":"traceutil/trace.go:171","msg":"trace[1853719040] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1198; }","duration":"588.723158ms","start":"2026-05-20T21:29:49.672423Z","end":"2026-05-20T21:29:50.261146Z","steps":["trace[1853719040] 'agreement among raft nodes before linearized reading' (duration: 588.651045ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:29:50.261179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:29:49.672401Z","time spent":"588.773098ms","remote":"127.0.0.1:44802","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":"warn","ts":"2026-05-20T21:29:50.261387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.45838ms","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-05-20T21:29:50.261419Z","caller":"traceutil/trace.go:171","msg":"trace[1098331679] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1198; }","duration":"492.526732ms","start":"2026-05-20T21:29:49.768884Z","end":"2026-05-20T21:29:50.26141Z","steps":["trace[1098331679] 'agreement among raft nodes before linearized reading' (duration: 492.45352ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:29:50.261443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:29:49.768866Z","time spent":"492.571023ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-20T21:29:50.448557Z","caller":"traceutil/trace.go:171","msg":"trace[1782437259] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"183.447005ms","start":"2026-05-20T21:29:50.265068Z","end":"2026-05-20T21:29:50.448515Z","steps":["trace[1782437259] 'process raft request' (duration: 178.011306ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:29:50.466278Z","caller":"traceutil/trace.go:171","msg":"trace[2030643050] linearizableReadLoop","detail":"{readStateIndex:1254; appliedIndex:1250; }","duration":"185.341058ms","start":"2026-05-20T21:29:50.280918Z","end":"2026-05-20T21:29:50.466259Z","steps":["trace[2030643050] 'read index received' (duration: 162.171333ms)","trace[2030643050] 'applied index is now lower than readState.Index' (duration: 23.169135ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:29:50.466312Z","caller":"traceutil/trace.go:171","msg":"trace[295927034] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"201.182351ms","start":"2026-05-20T21:29:50.265114Z","end":"2026-05-20T21:29:50.466297Z","steps":["trace[295927034] 'process raft request' (duration: 200.976185ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:29:50.466404Z","caller":"traceutil/trace.go:171","msg":"trace[1626665472] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"200.899883ms","start":"2026-05-20T21:29:50.265472Z","end":"2026-05-20T21:29:50.466372Z","steps":["trace[1626665472] 'process raft request' (duration: 200.735129ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:29:50.466426Z","caller":"traceutil/trace.go:171","msg":"trace[614340195] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"199.966418ms","start":"2026-05-20T21:29:50.266438Z","end":"2026-05-20T21:29:50.466404Z","steps":["trace[614340195] 'process raft request' (duration: 199.794022ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:29:50.466438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.502703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:29:50.466564Z","caller":"traceutil/trace.go:171","msg":"trace[2132301695] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1202; }","duration":"185.653236ms","start":"2026-05-20T21:29:50.280885Z","end":"2026-05-20T21:29:50.466539Z","steps":["trace[2132301695] 'agreement among raft nodes before linearized reading' (duration: 185.512792ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:30:04.685805Z","caller":"traceutil/trace.go:171","msg":"trace[374911666] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"146.243877ms","start":"2026-05-20T21:30:04.539538Z","end":"2026-05-20T21:30:04.685782Z","steps":["trace[374911666] 'process raft request' (duration: 146.193595ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:30:04.685858Z","caller":"traceutil/trace.go:171","msg":"trace[2076179897] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"146.311708ms","start":"2026-05-20T21:30:04.539528Z","end":"2026-05-20T21:30:04.68584Z","steps":["trace[2076179897] 'process raft request' (duration: 105.451379ms)","trace[2076179897] 'compare' (duration: 40.471859ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:30:06.743882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.319158ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T21:30:06.743999Z","caller":"traceutil/trace.go:171","msg":"trace[57181311] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"585.052716ms","start":"2026-05-20T21:30:06.158926Z","end":"2026-05-20T21:30:06.743979Z","steps":["trace[57181311] 'process raft request' (duration: 246.555183ms)","trace[57181311] 'compare' (duration: 338.154804ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:30:06.744062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:30:06.158905Z","time spent":"585.130939ms","remote":"127.0.0.1:44698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":915,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:30:06.746614Z","caller":"traceutil/trace.go:171","msg":"trace[543850459] linearizableReadLoop","detail":"{readStateIndex:1327; appliedIndex:1324; }","duration":"465.278335ms","start":"2026-05-20T21:30:06.281316Z","end":"2026-05-20T21:30:06.746595Z","steps":["trace[543850459] 'read index received' (duration: 124.177352ms)","trace[543850459] 'applied index is now lower than readState.Index' (duration: 341.100113ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:30:06.746722Z","caller":"traceutil/trace.go:171","msg":"trace[1211981372] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"587.322739ms","start":"2026-05-20T21:30:06.159389Z","end":"2026-05-20T21:30:06.746711Z","steps":["trace[1211981372] 'process raft request' (duration: 587.015211ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:30:06.746794Z","caller":"traceutil/trace.go:171","msg":"trace[128451795] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"435.024947ms","start":"2026-05-20T21:30:06.31175Z","end":"2026-05-20T21:30:06.746775Z","steps":["trace[128451795] 'process raft request' (duration: 434.79833ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:30:06.746821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:30:06.159372Z","time spent":"587.37999ms","remote":"127.0.0.1:44816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:30:06.746894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:30:06.311733Z","time spent":"435.110419ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:30:06.747119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.7993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:30:06.747177Z","caller":"traceutil/trace.go:171","msg":"trace[838690454] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1272; }","duration":"465.930944ms","start":"2026-05-20T21:30:06.281236Z","end":"2026-05-20T21:30:06.747167Z","steps":["trace[838690454] 'agreement among raft nodes before linearized reading' (duration: 465.853401ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:30:06.747204Z","caller":"traceutil/trace.go:171","msg":"trace[1324622222] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"582.754403ms","start":"2026-05-20T21:30:06.164437Z","end":"2026-05-20T21:30:06.747192Z","steps":["trace[1324622222] 'process raft request' (duration: 582.059385ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:30:06.747228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:30:06.281216Z","time spent":"466.005305ms","remote":"127.0.0.1:44536","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-05-20T21:30:06.747261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:30:06.164421Z","time spent":"582.808145ms","remote":"127.0.0.1:45026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9375,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:30:06.748926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.282522ms","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-05-20T21:30:06.748978Z","caller":"traceutil/trace.go:171","msg":"trace[1475288886] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1272; }","duration":"209.374355ms","start":"2026-05-20T21:30:06.539591Z","end":"2026-05-20T21:30:06.748965Z","steps":["trace[1475288886] 'agreement among raft nodes before linearized reading' (duration: 209.230252ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:30:06.749168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.214475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-20T21:30:06.749209Z","caller":"traceutil/trace.go:171","msg":"trace[1027608123] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1272; }","duration":"127.288386ms","start":"2026-05-20T21:30:06.621908Z","end":"2026-05-20T21:30:06.749197Z","steps":["trace[1027608123] 'agreement among raft nodes before linearized reading' (duration: 127.207924ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:30:06.74944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.085175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-20T21:30:06.749477Z","caller":"traceutil/trace.go:171","msg":"trace[803384514] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1272; }","duration":"183.122665ms","start":"2026-05-20T21:30:06.566345Z","end":"2026-05-20T21:30:06.749468Z","steps":["trace[803384514] 'agreement among raft nodes before linearized reading' (duration: 183.029663ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:30:13.175223Z","caller":"traceutil/trace.go:171","msg":"trace[803663417] linearizableReadLoop","detail":"{readStateIndex:1372; appliedIndex:1371; }","duration":"387.331999ms","start":"2026-05-20T21:30:12.787868Z","end":"2026-05-20T21:30:13.1752Z","steps":["trace[803663417] 'read index received' (duration: 387.065192ms)","trace[803663417] 'applied index is now lower than readState.Index' (duration: 265.697µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:30:13.17527Z","caller":"traceutil/trace.go:171","msg":"trace[866810331] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"404.651616ms","start":"2026-05-20T21:30:12.770588Z","end":"2026-05-20T21:30:13.175239Z","steps":["trace[866810331] 'process raft request' (duration: 404.46043ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:30:13.175436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:30:12.770567Z","time spent":"404.772989ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:30:13.17546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.584807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-20T21:30:13.17547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.933809ms","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-05-20T21:30:13.175494Z","caller":"traceutil/trace.go:171","msg":"trace[225602561] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1315; }","duration":"387.67589ms","start":"2026-05-20T21:30:12.787808Z","end":"2026-05-20T21:30:13.175484Z","steps":["trace[225602561] 'agreement among raft nodes before linearized reading' (duration: 387.530537ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:30:13.175517Z","caller":"traceutil/trace.go:171","msg":"trace[980492319] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1315; }","duration":"372.00196ms","start":"2026-05-20T21:30:12.803502Z","end":"2026-05-20T21:30:13.175504Z","steps":["trace[980492319] 'agreement among raft nodes before linearized reading' (duration: 371.876086ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:30:13.175528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:30:12.787787Z","time spent":"387.733191ms","remote":"127.0.0.1:44802","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":"warn","ts":"2026-05-20T21:30:13.175532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.095025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-20T21:30:13.175584Z","caller":"traceutil/trace.go:171","msg":"trace[1718166073] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1315; }","duration":"379.187267ms","start":"2026-05-20T21:30:12.796384Z","end":"2026-05-20T21:30:13.175571Z","steps":["trace[1718166073] 'agreement among raft nodes before linearized reading' (duration: 378.990441ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:30:13.175624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:30:12.796369Z","time spent":"379.248838ms","remote":"127.0.0.1:44802","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":"warn","ts":"2026-05-20T21:30:13.175549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:30:12.803494Z","time spent":"372.047771ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-20T21:30:13.175672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.519741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-20T21:30:13.175698Z","caller":"traceutil/trace.go:171","msg":"trace[527165562] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1315; }","duration":"377.573343ms","start":"2026-05-20T21:30:12.798117Z","end":"2026-05-20T21:30:13.17569Z","steps":["trace[527165562] 'agreement among raft nodes before linearized reading' (duration: 377.500811ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:30:13.175722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:30:12.798104Z","time spent":"377.612973ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-20T21:30:14.08071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.871866ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T21:30:14.080808Z","caller":"traceutil/trace.go:171","msg":"trace[1612900419] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"444.982379ms","start":"2026-05-20T21:30:13.635808Z","end":"2026-05-20T21:30:14.08079Z","steps":["trace[1612900419] 'process raft request' (duration: 198.968961ms)","trace[1612900419] 'compare' (duration: 245.686449ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:30:14.080865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:30:13.63579Z","time spent":"445.053592ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T21:30:14.277539Z","caller":"traceutil/trace.go:171","msg":"trace[862399405] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"191.743553ms","start":"2026-05-20T21:30:14.085766Z","end":"2026-05-20T21:30:14.277509Z","steps":["trace[862399405] 'process raft request' (duration: 172.080485ms)","trace[862399405] 'compare' (duration: 19.531254ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:30:14.357228Z","caller":"traceutil/trace.go:171","msg":"trace[953575366] linearizableReadLoop","detail":"{readStateIndex:1387; appliedIndex:1385; }","duration":"188.365139ms","start":"2026-05-20T21:30:14.168839Z","end":"2026-05-20T21:30:14.357204Z","steps":["trace[953575366] 'read index received' (duration: 89.1047ms)","trace[953575366] 'applied index is now lower than readState.Index' (duration: 99.259529ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:30:14.357446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.604477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-20T21:30:14.357486Z","caller":"traceutil/trace.go:171","msg":"trace[2050119903] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1330; }","duration":"188.681978ms","start":"2026-05-20T21:30:14.168788Z","end":"2026-05-20T21:30:14.35747Z","steps":["trace[2050119903] 'agreement among raft nodes before linearized reading' (duration: 188.529815ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:30:14.357475Z","caller":"traceutil/trace.go:171","msg":"trace[926081967] transaction","detail":"{read_only:false; response_revision:1330; number_of_response:1; }","duration":"269.162203ms","start":"2026-05-20T21:30:14.08825Z","end":"2026-05-20T21:30:14.357412Z","steps":["trace[926081967] 'process raft request' (duration: 268.813863ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:30:14.846477Z","caller":"traceutil/trace.go:171","msg":"trace[1156222045] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"579.577997ms","start":"2026-05-20T21:30:14.266874Z","end":"2026-05-20T21:30:14.846452Z","steps":["trace[1156222045] 'process raft request' (duration: 579.455003ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:30:14.846608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:30:14.266844Z","time spent":"579.705211ms","remote":"127.0.0.1:44596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":806,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T21:30:14.871421Z","caller":"traceutil/trace.go:171","msg":"trace[1105893831] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"508.663384ms","start":"2026-05-20T21:30:14.362735Z","end":"2026-05-20T21:30:14.871398Z","steps":["trace[1105893831] 'process raft request' (duration: 508.543791ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:30:14.87156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:30:14.3627Z","time spent":"508.789517ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:30:19.733984Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2280402815343508340,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-20T21:30:19.974771Z","caller":"traceutil/trace.go:171","msg":"trace[1691667121] linearizableReadLoop","detail":"{readStateIndex:1417; appliedIndex:1416; }","duration":"741.734198ms","start":"2026-05-20T21:30:19.233013Z","end":"2026-05-20T21:30:19.974747Z","steps":["trace[1691667121] 'read index received' (duration: 741.498481ms)","trace[1691667121] 'applied index is now lower than readState.Index' (duration: 234.577µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:30:19.97486Z","caller":"traceutil/trace.go:171","msg":"trace[1269621682] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"774.6214ms","start":"2026-05-20T21:30:19.200201Z","end":"2026-05-20T21:30:19.974822Z","steps":["trace[1269621682] 'process raft request' (duration: 774.310881ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:30:19.975133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.287585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T21:30:19.975197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:30:19.200181Z","time spent":"774.940798ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:30:19.975272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.44543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:30:19.975322Z","caller":"traceutil/trace.go:171","msg":"trace[2031290320] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1359; }","duration":"139.533673ms","start":"2026-05-20T21:30:19.835776Z","end":"2026-05-20T21:30:19.975309Z","steps":["trace[2031290320] 'agreement among raft nodes before linearized reading' (duration: 139.464331ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:30:19.975209Z","caller":"traceutil/trace.go:171","msg":"trace[1002748086] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1359; }","duration":"170.424149ms","start":"2026-05-20T21:30:19.804767Z","end":"2026-05-20T21:30:19.975192Z","steps":["trace[1002748086] 'agreement among raft nodes before linearized reading' (duration: 170.273324ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:30:19.975233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"724.728243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-05-20T21:30:19.975421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"723.88058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-20T21:30:19.975474Z","caller":"traceutil/trace.go:171","msg":"trace[446622697] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1359; }","duration":"723.932751ms","start":"2026-05-20T21:30:19.251529Z","end":"2026-05-20T21:30:19.975461Z","steps":["trace[446622697] 'agreement among raft nodes before linearized reading' (duration: 723.824328ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:30:19.975505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:30:19.251519Z","time spent":"723.977351ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-20T21:30:19.975567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.639837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-20T21:30:19.975325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.557084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-20T21:30:19.975684Z","caller":"traceutil/trace.go:171","msg":"trace[1730789543] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1359; }","duration":"722.821861ms","start":"2026-05-20T21:30:19.252832Z","end":"2026-05-20T21:30:19.975654Z","steps":["trace[1730789543] 'agreement among raft nodes before linearized reading' (duration: 722.41965ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:30:19.975728Z","caller":"traceutil/trace.go:171","msg":"trace[1048995139] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1359; }","duration":"722.968384ms","start":"2026-05-20T21:30:19.252741Z","end":"2026-05-20T21:30:19.975709Z","steps":["trace[1048995139] 'agreement among raft nodes before linearized reading' (duration: 722.326596ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:30:19.975751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:30:19.252803Z","time spent":"722.928084ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-20T21:30:19.975788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:30:19.252736Z","time spent":"723.035056ms","remote":"127.0.0.1:44802","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-05-20T21:30:19.976211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"743.187068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-20T21:30:19.976274Z","caller":"traceutil/trace.go:171","msg":"trace[2095329657] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1359; }","duration":"743.27926ms","start":"2026-05-20T21:30:19.23298Z","end":"2026-05-20T21:30:19.976259Z","steps":["trace[2095329657] 'agreement among raft nodes before linearized reading' (duration: 741.876542ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:30:19.976369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:30:19.232964Z","time spent":"743.390563ms","remote":"127.0.0.1:44802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-20T21:30:19.975445Z","caller":"traceutil/trace.go:171","msg":"trace[870711338] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1359; }","duration":"725.093213ms","start":"2026-05-20T21:30:19.250333Z","end":"2026-05-20T21:30:19.975426Z","steps":["trace[870711338] 'agreement among raft nodes before linearized reading' (duration: 724.657601ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:30:19.97772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T21:30:19.25032Z","time spent":"727.380095ms","remote":"127.0.0.1:44802","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\" "}